[11:29:58.878] New invocation is queued and will start shortly
[11:29:59.979] Starting the invocation (attempt 1)
[11:30:00.021] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:30:00.021] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:30:00.021] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9083446910880023024",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"04725101220a8d0b58ca69e7e6f96e65e8c58563\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9083446910880023024",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/04725101220a8d0b58ca69e7e6f96e65e8c58563",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/04725101220a8d0b58ca69e7e6f96e65e8c58563",
"gitiles_ref:refs/heads/master"
]
}
[11:30:01.767] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1553513400261409",
"id": "8918016848765748848",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"04725101220a8d0b58ca69e7e6f96e65e8c58563\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1553513401546443",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11538",
"builder:linux-chromeos-dbg",
"buildset:commit/git/04725101220a8d0b58ca69e7e6f96e65e8c58563",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/04725101220a8d0b58ca69e7e6f96e65e8c58563",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083446910880023024",
"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/8918016848765748848/+/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:43cd6ed2338ae710",
"user_agent:luci-scheduler"
],
"updated_ts": "1553513401546573",
"url": "https://ci.chromium.org/b/8918016848765748848",
"utcnow_ts": "1553513401753427"
}
}
[11:30:01.767] Task URL: https://ci.chromium.org/b/8918016848765748848
[11:30:01.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:2:0) after 1m0s
[11:31:01.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:2:0)
[11:31:01.785] Timer tick, asking Buildbucket for the build status
[11:31:02.281] Build 8918016848765748848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:31:02.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:3:0) after 1m0s
[11:32:02.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:3:0)
[11:32:02.306] Timer tick, asking Buildbucket for the build status
[11:32:02.750] Build 8918016848765748848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:32:02.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:4:0) after 1m0s
[11:33:02.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:4:0)
[11:33:02.770] Timer tick, asking Buildbucket for the build status
[11:33:03.395] Build 8918016848765748848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:33:03.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:5:0) after 1m0s
[11:34:03.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:5:0)
[11:34:03.411] Timer tick, asking Buildbucket for the build status
[11:34:03.532] Build 8918016848765748848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:34:03.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:6:0) after 1m0s
[11:35:03.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:6:0)
[11:35:03.512] Timer tick, asking Buildbucket for the build status
[11:35:03.967] Build 8918016848765748848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:35:03.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:7:0) after 1m0s
[11:35:04.666] Received PubSub notification, asking Buildbucket for the build status
[11:35:04.784] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:03.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:7:0)
[11:36:03.989] Timer tick, asking Buildbucket for the build status
[11:36:04.658] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:04.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:9:0) after 1m0s
[11:37:04.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:9:0)
[11:37:04.677] Timer tick, asking Buildbucket for the build status
[11:37:05.118] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:05.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:10:0) after 1m0s
[11:38:05.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:10:0)
[11:38:05.170] Timer tick, asking Buildbucket for the build status
[11:38:05.465] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:05.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:11:0) after 1m0s
[11:39:05.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:11:0)
[11:39:05.487] Timer tick, asking Buildbucket for the build status
[11:39:05.788] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:05.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:12:0) after 1m0s
[11:40:05.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:12:0)
[11:40:05.785] Timer tick, asking Buildbucket for the build status
[11:40:06.555] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:06.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:13:0) after 1m0s
[11:41:06.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:13:0)
[11:41:06.571] Timer tick, asking Buildbucket for the build status
[11:41:06.884] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:06.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:14:0) after 1m0s
[11:42:06.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:14:0)
[11:42:06.902] Timer tick, asking Buildbucket for the build status
[11:42:07.600] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:07.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:15:0) after 1m0s
[11:43:07.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:15:0)
[11:43:07.627] Timer tick, asking Buildbucket for the build status
[11:43:08.169] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:08.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:16:0) after 1m0s
[11:44:08.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:16:0)
[11:44:08.188] Timer tick, asking Buildbucket for the build status
[11:44:10.025] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:10.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:17:0) after 1m0s
[11:45:10.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:17:0)
[11:45:10.047] Timer tick, asking Buildbucket for the build status
[11:45:10.268] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:10.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:18:0) after 1m0s
[11:46:10.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:18:0)
[11:46:10.264] Timer tick, asking Buildbucket for the build status
[11:46:10.521] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:10.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:19:0) after 1m0s
[11:47:10.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:19:0)
[11:47:10.533] Timer tick, asking Buildbucket for the build status
[11:47:10.654] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:10.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:20:0) after 1m0s
[11:48:10.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:20:0)
[11:48:10.669] Timer tick, asking Buildbucket for the build status
[11:48:11.254] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:11.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:21:0) after 1m0s
[11:49:11.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:21:0)
[11:49:11.274] Timer tick, asking Buildbucket for the build status
[11:49:11.416] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:11.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:22:0) after 1m0s
[11:50:11.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:22:0)
[11:50:11.451] Timer tick, asking Buildbucket for the build status
[11:50:11.555] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:11.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:23:0) after 1m0s
[11:51:11.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:23:0)
[11:51:11.570] Timer tick, asking Buildbucket for the build status
[11:51:11.684] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:11.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:24:0) after 1m0s
[11:52:11.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:24:0)
[11:52:11.715] Timer tick, asking Buildbucket for the build status
[11:52:12.014] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:12.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:25:0) after 1m0s
[11:53:12.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:25:0)
[11:53:12.031] Timer tick, asking Buildbucket for the build status
[11:53:12.178] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:12.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:26:0) after 1m0s
[11:54:12.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:26:0)
[11:54:12.182] Timer tick, asking Buildbucket for the build status
[11:54:12.288] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:12.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:27:0) after 1m0s
[11:55:12.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:27:0)
[11:55:12.306] Timer tick, asking Buildbucket for the build status
[11:55:12.498] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:12.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:28:0) after 1m0s
[11:56:12.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:28:0)
[11:56:12.503] Timer tick, asking Buildbucket for the build status
[11:56:13.064] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:13.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:29:0) after 1m0s
[11:57:13.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:29:0)
[11:57:13.041] Timer tick, asking Buildbucket for the build status
[11:57:13.393] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:13.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:30:0) after 1m0s
[11:58:13.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:30:0)
[11:58:13.397] Timer tick, asking Buildbucket for the build status
[11:58:13.890] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:13.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:31:0) after 1m0s
[11:59:13.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:31:0)
[11:59:13.911] Timer tick, asking Buildbucket for the build status
[11:59:14.195] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:14.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:32:0) after 1m0s
[12:00:14.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:32:0)
[12:00:14.217] Timer tick, asking Buildbucket for the build status
[12:00:15.470] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:15.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:33:0) after 1m0s
[12:01:15.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:33:0)
[12:01:15.499] Timer tick, asking Buildbucket for the build status
[12:01:15.951] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:15.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:34:0) after 1m0s
[12:02:15.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:34:0)
[12:02:15.952] Timer tick, asking Buildbucket for the build status
[12:02:16.044] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:16.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:35:0) after 1m0s
[12:03:16.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:35:0)
[12:03:16.078] Timer tick, asking Buildbucket for the build status
[12:03:16.323] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:16.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:36:0) after 1m0s
[12:04:16.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:36:0)
[12:04:16.324] Timer tick, asking Buildbucket for the build status
[12:04:16.767] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:16.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:37:0) after 1m0s
[12:05:16.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:37:0)
[12:05:16.778] Timer tick, asking Buildbucket for the build status
[12:05:16.994] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:16.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:38:0) after 1m0s
[12:06:17.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:38:0)
[12:06:17.018] Timer tick, asking Buildbucket for the build status
[12:06:17.449] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:17.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:39:0) after 1m0s
[12:07:17.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:39:0)
[12:07:17.468] Timer tick, asking Buildbucket for the build status
[12:07:17.829] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:17.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:40:0) after 1m0s
[12:08:17.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:40:0)
[12:08:17.849] Timer tick, asking Buildbucket for the build status
[12:08:17.979] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:17.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:41:0) after 1m0s
[12:09:18.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:41:0)
[12:09:18.006] Timer tick, asking Buildbucket for the build status
[12:09:18.923] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:18.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:42:0) after 1m0s
[12:10:18.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:42:0)
[12:10:18.914] Timer tick, asking Buildbucket for the build status
[12:10:19.410] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:19.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:43:0) after 1m0s
[12:11:19.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:43:0)
[12:11:19.402] Timer tick, asking Buildbucket for the build status
[12:11:19.582] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:19.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:44:0) after 1m0s
[12:12:19.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:44:0)
[12:12:19.602] Timer tick, asking Buildbucket for the build status
[12:12:19.870] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:19.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:45:0) after 1m0s
[12:13:19.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:45:0)
[12:13:19.919] Timer tick, asking Buildbucket for the build status
[12:13:20.492] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:20.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:46:0) after 1m0s
[12:14:20.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:46:0)
[12:14:20.513] Timer tick, asking Buildbucket for the build status
[12:14:20.999] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:20.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:47:0) after 1m0s
[12:15:21.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:47:0)
[12:15:21.021] Timer tick, asking Buildbucket for the build status
[12:15:21.291] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:21.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:48:0) after 1m0s
[12:16:21.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:48:0)
[12:16:21.315] Timer tick, asking Buildbucket for the build status
[12:16:22.313] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:22.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:49:0) after 1m0s
[12:17:22.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:49:0)
[12:17:22.324] Timer tick, asking Buildbucket for the build status
[12:17:23.312] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:23.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:50:0) after 1m0s
[12:18:23.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:50:0)
[12:18:23.387] Timer tick, asking Buildbucket for the build status
[12:18:23.611] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:23.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:51:0) after 1m0s
[12:19:23.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:51:0)
[12:19:23.632] Timer tick, asking Buildbucket for the build status
[12:19:23.910] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:23.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:52:0) after 1m0s
[12:20:23.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:52:0)
[12:20:23.901] Timer tick, asking Buildbucket for the build status
[12:20:24.368] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:24.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:53:0) after 1m0s
[12:21:24.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:53:0)
[12:21:24.389] Timer tick, asking Buildbucket for the build status
[12:21:25.095] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:25.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:54:0) after 1m0s
[12:22:25.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:54:0)
[12:22:25.102] Timer tick, asking Buildbucket for the build status
[12:22:25.922] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:25.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:55:0) after 1m0s
[12:23:25.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:55:0)
[12:23:25.906] Timer tick, asking Buildbucket for the build status
[12:23:26.016] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:26.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:56:0) after 1m0s
[12:24:26.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:56:0)
[12:24:26.039] Timer tick, asking Buildbucket for the build status
[12:24:26.516] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:26.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:57:0) after 1m0s
[12:25:26.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:57:0)
[12:25:26.536] Timer tick, asking Buildbucket for the build status
[12:25:26.675] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:26.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:58:0) after 1m0s
[12:26:26.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:58:0)
[12:26:26.650] Timer tick, asking Buildbucket for the build status
[12:26:26.996] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:26.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:59:0) after 1m0s
[12:27:27.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:59:0)
[12:27:27.000] Timer tick, asking Buildbucket for the build status
[12:27:27.934] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:27.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:60:0) after 1m0s
[12:28:27.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:60:0)
[12:28:27.985] Timer tick, asking Buildbucket for the build status
[12:28:28.105] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:28.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:61:0) after 1m0s
[12:29:28.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:61:0)
[12:29:28.124] Timer tick, asking Buildbucket for the build status
[12:29:28.497] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:28.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:62:0) after 1m0s
[12:30:28.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:62:0)
[12:30:28.483] Timer tick, asking Buildbucket for the build status
[12:30:28.596] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:28.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:63:0) after 1m0s
[12:31:28.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:63:0)
[12:31:28.616] Timer tick, asking Buildbucket for the build status
[12:31:29.166] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:29.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:64:0) after 1m0s
[12:32:29.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:64:0)
[12:32:29.142] Timer tick, asking Buildbucket for the build status
[12:32:29.349] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:29.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:65:0) after 1m0s
[12:33:29.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:65:0)
[12:33:29.370] Timer tick, asking Buildbucket for the build status
[12:33:29.642] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:29.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:66:0) after 1m0s
[12:34:29.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:66:0)
[12:34:29.663] Timer tick, asking Buildbucket for the build status
[12:34:29.880] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:29.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:67:0) after 1m0s
[12:35:29.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:67:0)
[12:35:29.863] Timer tick, asking Buildbucket for the build status
[12:35:30.809] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:30.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:68:0) after 1m0s
[12:36:30.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:68:0)
[12:36:30.789] Timer tick, asking Buildbucket for the build status
[12:36:31.589] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:31.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:69:0) after 1m0s
[12:37:31.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:69:0)
[12:37:31.579] Timer tick, asking Buildbucket for the build status
[12:37:31.736] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:31.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:70:0) after 1m0s
[12:38:31.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:70:0)
[12:38:31.716] Timer tick, asking Buildbucket for the build status
[12:38:31.836] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:31.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:71:0) after 1m0s
[12:39:31.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:71:0)
[12:39:31.907] Timer tick, asking Buildbucket for the build status
[12:39:32.736] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:32.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:72:0) after 1m0s
[12:40:32.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:72:0)
[12:40:32.763] Timer tick, asking Buildbucket for the build status
[12:40:32.897] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:32.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:73:0) after 1m0s
[12:41:32.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:73:0)
[12:41:32.917] Timer tick, asking Buildbucket for the build status
[12:41:33.485] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:33.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:74:0) after 1m0s
[12:42:33.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:74:0)
[12:42:33.505] Timer tick, asking Buildbucket for the build status
[12:42:33.890] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:33.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:75:0) after 1m0s
[12:43:33.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:75:0)
[12:43:33.874] Timer tick, asking Buildbucket for the build status
[12:43:34.485] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:34.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:76:0) after 1m0s
[12:44:34.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:76:0)
[12:44:34.507] Timer tick, asking Buildbucket for the build status
[12:44:34.672] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:34.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:77:0) after 1m0s
[12:45:34.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:77:0)
[12:45:34.677] Timer tick, asking Buildbucket for the build status
[12:45:34.878] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:34.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:78:0) after 1m0s
[12:46:34.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:78:0)
[12:46:34.875] Timer tick, asking Buildbucket for the build status
[12:46:35.167] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:35.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:79:0) after 1m0s
[12:47:35.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:79:0)
[12:47:35.255] Timer tick, asking Buildbucket for the build status
[12:47:35.573] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:35.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:80:0) after 1m0s
[12:48:35.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:80:0)
[12:48:35.595] Timer tick, asking Buildbucket for the build status
[12:48:35.771] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:35.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:81:0) after 1m0s
[12:49:35.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:81:0)
[12:49:35.774] Timer tick, asking Buildbucket for the build status
[12:49:35.902] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:35.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:82:0) after 1m0s
[12:50:35.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:82:0)
[12:50:35.922] Timer tick, asking Buildbucket for the build status
[12:50:36.638] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:36.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:83:0) after 1m0s
[12:51:36.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:83:0)
[12:51:36.666] Timer tick, asking Buildbucket for the build status
[12:51:37.020] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:37.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:84:0) after 1m0s
[12:52:37.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:84:0)
[12:52:37.072] Timer tick, asking Buildbucket for the build status
[12:52:37.177] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:37.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:85:0) after 1m0s
[12:53:37.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:85:0)
[12:53:37.200] Timer tick, asking Buildbucket for the build status
[12:53:37.992] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:37.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:86:0) after 1m0s
[12:54:37.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:86:0)
[12:54:37.996] Timer tick, asking Buildbucket for the build status
[12:54:38.218] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:38.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:87:0) after 1m0s
[12:55:38.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:87:0)
[12:55:38.224] Timer tick, asking Buildbucket for the build status
[12:55:38.364] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:38.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:88:0) after 1m0s
[12:56:38.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:88:0)
[12:56:38.355] Timer tick, asking Buildbucket for the build status
[12:56:38.492] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:38.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:89:0) after 1m0s
[12:57:38.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:89:0)
[12:57:38.525] Timer tick, asking Buildbucket for the build status
[12:57:38.808] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:38.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:90:0) after 1m0s
[12:58:38.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:90:0)
[12:58:38.828] Timer tick, asking Buildbucket for the build status
[12:58:38.934] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:38.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:91:0) after 1m0s
[12:59:38.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:91:0)
[12:59:38.958] Timer tick, asking Buildbucket for the build status
[12:59:39.115] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:39.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:92:0) after 1m0s
[13:00:39.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:92:0)
[13:00:39.094] Timer tick, asking Buildbucket for the build status
[13:00:40.490] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:40.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:93:0) after 1m0s
[13:01:40.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:93:0)
[13:01:40.493] Timer tick, asking Buildbucket for the build status
[13:01:40.712] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:40.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:94:0) after 1m0s
[13:02:40.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:94:0)
[13:02:40.734] Timer tick, asking Buildbucket for the build status
[13:02:42.397] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:42.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:95:0) after 1m0s
[13:03:42.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:95:0)
[13:03:42.436] Timer tick, asking Buildbucket for the build status
[13:03:42.547] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:42.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:96:0) after 1m0s
[13:04:42.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:96:0)
[13:04:42.544] Timer tick, asking Buildbucket for the build status
[13:04:42.668] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:42.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:97:0) after 1m0s
[13:05:42.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:97:0)
[13:05:42.641] Timer tick, asking Buildbucket for the build status
[13:05:42.743] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:42.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:98:0) after 1m0s
[13:06:42.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:98:0)
[13:06:42.764] Timer tick, asking Buildbucket for the build status
[13:06:42.856] Build 8918016848765748848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:42.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:99:0) after 1m0s
[13:07:42.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083446910880023024:99:0)
[13:07:42.874] Timer tick, asking Buildbucket for the build status
[13:07:43.044] Build 8918016848765748848: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[13:07:43.044] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1553519261698536",
"created_by": "project:chromium",
"created_ts": "1553513400261409",
"failure_reason": "BUILD_FAILURE",
"id": "8918016848765748848",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"04725101220a8d0b58ca69e7e6f96e65e8c58563\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"3 tests failed: ['non_network_service_browser_tests', 'webui_polymer1_browser_tests', 'non_network_service_interactive_ui_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\": 11538, \"got_angle_revision\": \"eae464dd3092c1c09c4dc4d51a0f50ac5d007722\", \"got_dawn_revision\": \"041aca1620e8f905df3342882af33618803b8a41\", \"got_nacl_revision\": \"de8da4841bc3d1ed020d798d5a7fd6fb3d817fa1\", \"got_revision\": \"04725101220a8d0b58ca69e7e6f96e65e8c58563\", \"got_revision_cp\": \"refs/heads/master@{#643799}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"3ed35ed809a6b87d0c738a62878b6cc5aeab6c60\", \"got_v8_revision_cp\": \"refs/heads/7.5.104@{#1}\", \"got_webrtc_revision\": \"0cd95081c053c9ab781a8e070162da4a424239ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27258}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"04725101220a8d0b58ca69e7e6f96e65e8c58563\", \"swarm_hashes\": {\"accessibility_unittests\": \"74316bba2e2267ad6dbf1cc6595205e14a2c5d4e\", \"angle_unittests\": \"6575595447cb4902912572217de191942227d3f8\", \"app_list_unittests\": \"f8ef2cdd041cfdba1020abc64f7a6dccfea4f10c\", \"app_shell_unittests\": \"06890248a608f08de82a46da89060551fc3d3cf8\", \"ash_unittests\": \"6266b4574dccdaab248dc61613160b07253fca5d\", \"aura_unittests\": \"e020fe571252f7c303dbd2c97a834d8ff7be5c8f\", \"base_unittests\": \"42258fd5ac235816601e09eb7c01f731f1b5873e\", \"blink_common_unittests\": \"97487216a54a29657bbc7faecf85f9d916bf4c3c\", \"blink_fuzzer_unittests\": \"5ac4df09fb7d39b756a5a1d123444c4e3fbc3ff8\", \"blink_heap_unittests\": \"09454bdfcdc10d090600dd9d6901aa709a34dea1\", \"blink_platform_unittests\": \"0833d990c6f72e8113542b11a3304a679ad9ca88\", \"blink_unittests\": \"a92751f781326805a007a0f4d673f3404700b3ac\", \"boringssl_crypto_tests\": \"80ff09dee518ca3f43f55977bf27631dc38ce026\", \"boringssl_ssl_tests\": \"c8b70381da22fbd31cf49e9893cbf1ccbf6dcfc4\", \"browser_tests\": \"b0063b79e57f057f2807802d0881ad3b9d411fa1\", \"cacheinvalidation_unittests\": \"f2648a6d089e470a4cc348a3d9a8b42ea852803f\", \"capture_unittests\": \"5b89a05f6940c554594659421a52c8d81ab2ead9\", \"cast_unittests\": \"ac285c4fdbe784c96e01de90fef23400f233dbd9\", \"cc_unittests\": \"67f8cd8695391560755246da3be3380f87604c50\", \"chrome_app_unittests\": \"f6ec6177932d8d42460c978d7f3896d758df50ad\", \"chromedriver_unittests\": \"b0597e4d849806244e18ed31ed20ffad2c977ccc\", \"chromeos_components_unittests\": \"fdf90662cdcb87d5fd2332d0d94f843ae38bf809\", \"chromeos_unittests\": \"36d9b86afaf17a3a1214030a79c865e1ea3cb395\", \"components_browsertests\": \"385e60ed29cde4455f8a0b3f6f676fb18fa168d7\", \"components_unittests\": \"b1063e0200ff53ac76d54988b8da4b453790dd9d\", \"compositor_unittests\": \"6afe7411049010b26789a2a728d1116b7ba75a11\", \"content_browsertests\": \"e66385a9d159cf0db12e38067374271ea6ca144b\", \"content_unittests\": \"f8fc83fcac98a773417971180e48d2730689fdf7\", \"crypto_unittests\": \"1678c68c288dbab132bc5fd6196122786f1ae840\", \"dbus_unittests\": \"3dcf92190a628444ab343c7dcc4e53c4bbf68049\", \"device_unittests\": \"8241527f5962504ce76c9f528f220820acded6c0\", \"display_unittests\": \"fa606eea929a3c0d09ff6e8f00a168cb44549e8c\", \"events_unittests\": \"560a737bcfceccfc2c4ecd7ee60a013b185656c2\", \"exo_unittests\": \"b44038d351ad3040aefa98f176b2275b196f9867\", \"extensions_browsertests\": \"0672a62cea96c42bfc12ef5860e8d0a17300a3a0\", \"extensions_unittests\": \"89e8cafcd980810c1fa4046ffb5c2ad9bc55d2c3\", \"filesystem_service_unittests\": \"96926605fd818f57fbb4c9fa6626f39d89a54e55\", \"gcm_unit_tests\": \"a524441a7f17a758ce3d8e52074341a2ba207d7a\", \"gfx_unittests\": \"bb4c03093b5124842e33053257d88f9ffa6a3d06\", \"gin_unittests\": \"a1a1b80638d59667d319f531ebdbae1aabe78157\", \"gl_unittests_ozone\": \"2bbcf73bda0f5979a2a4243bb4c108580646bbc8\", \"google_apis_unittests\": \"240956949e70784982aea4e6d6c7eb7fdf3b01cd\", \"gpu_unittests\": \"60ef76f3cb3912e7c5a251871f34e33c69daa1d0\", \"interactive_ui_tests\": \"616cb48c6df7e1defd7927479719673b0471b32d\", \"ipc_tests\": \"b1af0c8404674626630f6d9087f4a1b713443988\", \"jingle_unittests\": \"671cf7b465d4b7d24fade0465389740e002bc515\", \"keyboard_unittests\": \"741c5ccac22633b2d22228aeea5029a50f1f72d1\", \"latency_unittests\": \"045f5c1d7cb7a95ff80bad70dbaf6f515654ce14\", \"leveldb_service_unittests\": \"7bec8d6c2d1ee5a75c86707ad3337d103d8a5fbe\", \"libjingle_xmpp_unittests\": \"0231002ad0a4e6ebdbfce8e9ccf3216c0b27e616\", \"media_blink_unittests\": \"576b1c8d33332f0b981f0fe33fa6e79720b89099\", \"media_service_unittests\": \"565676d8390581dd0702926c308218c8aa671a65\", \"media_unittests\": \"5529166e3265f85815602e16da4976f5d79db682\", \"message_center_unittests\": \"a7cff1ac243d3635895a3f7aeaa2206bdb7c0d82\", \"midi_unittests\": \"e9ee4e6f7c8a92cce705d48f751a2f82986b36b0\", \"mojo_core_unittests\": \"b40c963d0576c99bbe4f31e98d5e3c2c260f27c5\", \"mojo_unittests\": \"c1ceaab2d368328fff70fdf63b9c34298d04f2fc\", \"nacl_helper_nonsfi_unittests\": \"c85478749f5bc21b07e6418a171fb7ab209115fd\", \"nacl_loader_unittests\": \"c969cd1887d70fd5e8fe0d457f200d79f790d0d2\", \"native_theme_unittests\": \"05e6c2501e2abd464081a19d1f72689944022ccc\", \"net_unittests\": \"ada846ea1f7e237172b5899a65fa4b33fb4daec8\", \"ozone_gl_unittests\": \"739c59cc70d4b2bfc7cb8a1a1bc5d2de01ca23d5\", \"ozone_unittests\": \"bd76047384452be6d76661cd34eba5d8a93c9038\", \"ozone_x11_unittests\": \"4be78a918338b8f51984e3852f4589079cb0353a\", \"pdf_unittests\": \"21177847e8b1777c68619b81a58e51d750fa098c\", \"perfetto_unittests\": \"672eb5fdf5b1684e3fa9034bfd75faaa9db70fd9\", \"ppapi_unittests\": \"d6c49250b5b0bdb6447a6fc8db08798b11df2cc8\", \"printing_unittests\": \"e1e90547dce020946d62458edd7c6ebd1ce0aefa\", \"remoting_unittests\": \"d8bcc092c98c596a35fe74a2a55cb3736048cf4e\", \"sandbox_linux_unittests\": \"7615fd36485633402540f39bebc7bcdb3a093a10\", \"service_manager_unittests\": \"9cdac2c5bbd0ce3f8c0fe0ab735dfaeb3d9e3b71\", \"services_unittests\": \"e5cd84a313565dc9f93440b8069ba9daf1cf7321\", \"shell_dialogs_unittests\": \"ff4c18835960342b36948b995bfac0bfa14eeb3d\", \"skia_unittests\": \"6e8fdac112c88202c44fa492da85c32173989561\", \"snapshot_unittests\": \"27e2157f83ec6ebe03c62515dddb96a0af5b56fe\", \"sql_unittests\": \"cb99fb597e0f64ea89454db85b58f52fc97061a1\", \"storage_unittests\": \"43aeb3197e9b1b763366b500012460c253104bdf\", \"sync_integration_tests\": \"b3f0634c8570d911e15a5c871d87cc1e6b8ec2ba\", \"traffic_annotation_auditor_unittests\": \"3a71f60ad016771f5b694c9cce09d7db096a059d\", \"ui_base_unittests\": \"00c80cb8de2b7d22e34fbe38d253c665b049e4a7\", \"ui_chromeos_unittests\": \"f4175e9256e2ed1a75f45957d5671d893f9347f6\", \"ui_touch_selection_unittests\": \"0550c72ac767e961b71444ff6fae3244c85dff21\", \"unit_tests\": \"5c42bd08457758e13f5507a556fb50bd95c508b9\", \"url_unittests\": \"b5df3a7c5d358de9a1b768ff63d9c9106ce6ea16\", \"usage_time_limit_unittests\": \"5b961fc2ca3fb94c09adddb43ebac692271cba43\", \"views_unittests\": \"044aa9924ba8ea0a7e8670d43d22c18fd6e63bcf\", \"viz_unittests\": \"f3612a5739d530a13baf644ea85b2e8c0e08e983\", \"wm_unittests\": \"b7461330124ff5e8ec417b68c2bef4ad63dbef77\", \"wtf_unittests\": \"5f24f64da6a35ffd1b69765ce035f2723f4e4193\"}, \"swarm_hashes_refs/heads/master(at){#643799}_without_patch\": {\"accessibility_unittests\": \"74316bba2e2267ad6dbf1cc6595205e14a2c5d4e\", \"angle_unittests\": \"6575595447cb4902912572217de191942227d3f8\", \"app_list_unittests\": \"f8ef2cdd041cfdba1020abc64f7a6dccfea4f10c\", \"app_shell_unittests\": \"06890248a608f08de82a46da89060551fc3d3cf8\", \"ash_unittests\": \"6266b4574dccdaab248dc61613160b07253fca5d\", \"aura_unittests\": \"e020fe571252f7c303dbd2c97a834d8ff7be5c8f\", \"base_unittests\": \"42258fd5ac235816601e09eb7c01f731f1b5873e\", \"blink_common_unittests\": \"97487216a54a29657bbc7faecf85f9d916bf4c3c\", \"blink_fuzzer_unittests\": \"5ac4df09fb7d39b756a5a1d123444c4e3fbc3ff8\", \"blink_heap_unittests\": \"09454bdfcdc10d090600dd9d6901aa709a34dea1\", \"blink_platform_unittests\": \"0833d990c6f72e8113542b11a3304a679ad9ca88\", \"blink_unittests\": \"a92751f781326805a007a0f4d673f3404700b3ac\", \"boringssl_crypto_tests\": \"80ff09dee518ca3f43f55977bf27631dc38ce026\", \"boringssl_ssl_tests\": \"c8b70381da22fbd31cf49e9893cbf1ccbf6dcfc4\", \"browser_tests\": \"b0063b79e57f057f2807802d0881ad3b9d411fa1\", \"cacheinvalidation_unittests\": \"f2648a6d089e470a4cc348a3d9a8b42ea852803f\", \"capture_unittests\": \"5b89a05f6940c554594659421a52c8d81ab2ead9\", \"cast_unittests\": \"ac285c4fdbe784c96e01de90fef23400f233dbd9\", \"cc_unittests\": \"67f8cd8695391560755246da3be3380f87604c50\", \"chrome_app_unittests\": \"f6ec6177932d8d42460c978d7f3896d758df50ad\", \"chromedriver_unittests\": \"b0597e4d849806244e18ed31ed20ffad2c977ccc\", \"chromeos_components_unittests\": \"fdf90662cdcb87d5fd2332d0d94f843ae38bf809\", \"chromeos_unittests\": \"36d9b86afaf17a3a1214030a79c865e1ea3cb395\", \"components_browsertests\": \"385e60ed29cde4455f8a0b3f6f676fb18fa168d7\", \"components_unittests\": \"b1063e0200ff53ac76d54988b8da4b453790dd9d\", \"compositor_unittests\": \"6afe7411049010b26789a2a728d1116b7ba75a11\", \"content_browsertests\": \"e66385a9d159cf0db12e38067374271ea6ca144b\", \"content_unittests\": \"f8fc83fcac98a773417971180e48d2730689fdf7\", \"crypto_unittests\": \"1678c68c288dbab132bc5fd6196122786f1ae840\", \"dbus_unittests\": \"3dcf92190a628444ab343c7dcc4e53c4bbf68049\", \"device_unittests\": \"8241527f5962504ce76c9f528f220820acded6c0\", \"display_unittests\": \"fa606eea929a3c0d09ff6e8f00a168cb44549e8c\", \"events_unittests\": \"560a737bcfceccfc2c4ecd7ee60a013b185656c2\", \"exo_unittests\": \"b44038d351ad3040aefa98f176b2275b196f9867\", \"extensions_browsertests\": \"0672a62cea96c42bfc12ef5860e8d0a17300a3a0\", \"extensions_unittests\": \"89e8cafcd980810c1fa4046ffb5c2ad9bc55d2c3\", \"filesystem_service_unittests\": \"96926605fd818f57fbb4c9fa6626f39d89a54e55\", \"gcm_unit_tests\": \"a524441a7f17a758ce3d8e52074341a2ba207d7a\", \"gfx_unittests\": \"bb4c03093b5124842e33053257d88f9ffa6a3d06\", \"gin_unittests\": \"a1a1b80638d59667d319f531ebdbae1aabe78157\", \"gl_unittests_ozone\": \"2bbcf73bda0f5979a2a4243bb4c108580646bbc8\", \"google_apis_unittests\": \"240956949e70784982aea4e6d6c7eb7fdf3b01cd\", \"gpu_unittests\": \"60ef76f3cb3912e7c5a251871f34e33c69daa1d0\", \"interactive_ui_tests\": \"616cb48c6df7e1defd7927479719673b0471b32d\", \"ipc_tests\": \"b1af0c8404674626630f6d9087f4a1b713443988\", \"jingle_unittests\": \"671cf7b465d4b7d24fade0465389740e002bc515\", \"keyboard_unittests\": \"741c5ccac22633b2d22228aeea5029a50f1f72d1\", \"latency_unittests\": \"045f5c1d7cb7a95ff80bad70dbaf6f515654ce14\", \"leveldb_service_unittests\": \"7bec8d6c2d1ee5a75c86707ad3337d103d8a5fbe\", \"libjingle_xmpp_unittests\": \"0231002ad0a4e6ebdbfce8e9ccf3216c0b27e616\", \"media_blink_unittests\": \"576b1c8d33332f0b981f0fe33fa6e79720b89099\", \"media_service_unittests\": \"565676d8390581dd0702926c308218c8aa671a65\", \"media_unittests\": \"5529166e3265f85815602e16da4976f5d79db682\", \"message_center_unittests\": \"a7cff1ac243d3635895a3f7aeaa2206bdb7c0d82\", \"midi_unittests\": \"e9ee4e6f7c8a92cce705d48f751a2f82986b36b0\", \"mojo_core_unittests\": \"b40c963d0576c99bbe4f31e98d5e3c2c260f27c5\", \"mojo_unittests\": \"c1ceaab2d368328fff70fdf63b9c34298d04f2fc\", \"nacl_helper_nonsfi_unittests\": \"c85478749f5bc21b07e6418a171fb7ab209115fd\", \"nacl_loader_unittests\": \"c969cd1887d70fd5e8fe0d457f200d79f790d0d2\", \"native_theme_unittests\": \"05e6c2501e2abd464081a19d1f72689944022ccc\", \"net_unittests\": \"ada846ea1f7e237172b5899a65fa4b33fb4daec8\", \"ozone_gl_unittests\": \"739c59cc70d4b2bfc7cb8a1a1bc5d2de01ca23d5\", \"ozone_unittests\": \"bd76047384452be6d76661cd34eba5d8a93c9038\", \"ozone_x11_unittests\": \"4be78a918338b8f51984e3852f4589079cb0353a\", \"pdf_unittests\": \"21177847e8b1777c68619b81a58e51d750fa098c\", \"perfetto_unittests\": \"672eb5fdf5b1684e3fa9034bfd75faaa9db70fd9\", \"ppapi_unittests\": \"d6c49250b5b0bdb6447a6fc8db08798b11df2cc8\", \"printing_unittests\": \"e1e90547dce020946d62458edd7c6ebd1ce0aefa\", \"remoting_unittests\": \"d8bcc092c98c596a35fe74a2a55cb3736048cf4e\", \"sandbox_linux_unittests\": \"7615fd36485633402540f39bebc7bcdb3a093a10\", \"service_manager_unittests\": \"9cdac2c5bbd0ce3f8c0fe0ab735dfaeb3d9e3b71\", \"services_unittests\": \"e5cd84a313565dc9f93440b8069ba9daf1cf7321\", \"shell_dialogs_unittests\": \"ff4c18835960342b36948b995bfac0bfa14eeb3d\", \"skia_unittests\": \"6e8fdac112c88202c44fa492da85c32173989561\", \"snapshot_unittests\": \"27e2157f83ec6ebe03c62515dddb96a0af5b56fe\", \"sql_unittests\": \"cb99fb597e0f64ea89454db85b58f52fc97061a1\", \"storage_unittests\": \"43aeb3197e9b1b763366b500012460c253104bdf\", \"sync_integration_tests\": \"b3f0634c8570d911e15a5c871d87cc1e6b8ec2ba\", \"traffic_annotation_auditor_unittests\": \"3a71f60ad016771f5b694c9cce09d7db096a059d\", \"ui_base_unittests\": \"00c80cb8de2b7d22e34fbe38d253c665b049e4a7\", \"ui_chromeos_unittests\": \"f4175e9256e2ed1a75f45957d5671d893f9347f6\", \"ui_touch_selection_unittests\": \"0550c72ac767e961b71444ff6fae3244c85dff21\", \"unit_tests\": \"5c42bd08457758e13f5507a556fb50bd95c508b9\", \"url_unittests\": \"b5df3a7c5d358de9a1b768ff63d9c9106ce6ea16\", \"usage_time_limit_unittests\": \"5b961fc2ca3fb94c09adddb43ebac692271cba43\", \"views_unittests\": \"044aa9924ba8ea0a7e8670d43d22c18fd6e63bcf\", \"viz_unittests\": \"f3612a5739d530a13baf644ea85b2e8c0e08e983\", \"wm_unittests\": \"b7461330124ff5e8ec417b68c2bef4ad63dbef77\", \"wtf_unittests\": \"5f24f64da6a35ffd1b69765ce035f2723f4e4193\"}}, \"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\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"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\": [\"4216-cf4a3cd\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"3 tests failed: ['non_network_service_browser_tests', 'webui_polymer1_browser_tests', 'non_network_service_interactive_ui_tests']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1553513704076326",
"status": "COMPLETED",
"status_changed_ts": "1553513704456543",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11538",
"builder:linux-chromeos-dbg",
"buildset:commit/git/04725101220a8d0b58ca69e7e6f96e65e8c58563",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/04725101220a8d0b58ca69e7e6f96e65e8c58563",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083446910880023024",
"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/8918016848765748848/+/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:43cd6ed2338ae710",
"user_agent:luci-scheduler"
],
"updated_ts": "1553519262183798",
"url": "https://ci.chromium.org/b/8918016848765748848",
"utcnow_ts": "1553519263007749"
}
}
[13:07:43.044] Invocation finished in 1h37m44.182196118s with status FAILED