[00:16:24.319] New invocation is queued and will start shortly
[00:16:30.828] Starting the invocation (attempt 1)
[00:16:30.879] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:16:30.879] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:16:30.879] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9079321828162705920",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"b33fa5bead85d5d70e527831033d942347badf2b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9079321828162705920",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/b33fa5bead85d5d70e527831033d942347badf2b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b33fa5bead85d5d70e527831033d942347badf2b",
"gitiles_ref:refs/heads/master"
]
}
[00:16:32.625] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1557447391237741",
"id": "8913891760244443760",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b33fa5bead85d5d70e527831033d942347badf2b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1557447392066141",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12303",
"builder:linux-chromeos-dbg",
"buildset:commit/git/b33fa5bead85d5d70e527831033d942347badf2b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b33fa5bead85d5d70e527831033d942347badf2b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9079321828162705920",
"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/8913891760244443760/+/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": "1557447392066274",
"url": "https://ci.chromium.org/b/8913891760244443760",
"utcnow_ts": "1557447392602577"
}
}
[00:16:32.625] Task URL: https://ci.chromium.org/b/8913891760244443760
[00:16:32.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:2:0) after 1m0s
[00:17:32.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:2:0)
[00:17:32.626] Timer tick, asking Buildbucket for the build status
[00:17:32.989] Build 8913891760244443760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:32.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:3:0) after 1m0s
[00:18:33.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:3:0)
[00:18:33.063] Timer tick, asking Buildbucket for the build status
[00:18:33.736] Build 8913891760244443760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:33.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:4:0) after 1m0s
[00:19:33.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:4:0)
[00:19:33.839] Timer tick, asking Buildbucket for the build status
[00:19:33.958] Build 8913891760244443760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:33.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:5:0) after 1m0s
[00:20:33.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:5:0)
[00:20:33.935] Timer tick, asking Buildbucket for the build status
[00:20:34.919] Build 8913891760244443760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:34.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:6:0) after 1m0s
[00:21:34.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:6:0)
[00:21:34.899] Timer tick, asking Buildbucket for the build status
[00:21:36.517] Build 8913891760244443760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:36.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:7:0) after 1m0s
[00:22:36.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:7:0)
[00:22:36.504] Timer tick, asking Buildbucket for the build status
[00:22:36.861] Build 8913891760244443760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:36.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:8:0) after 1m0s
[00:23:36.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:8:0)
[00:23:36.925] Timer tick, asking Buildbucket for the build status
[00:23:37.125] Build 8913891760244443760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:37.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:9:0) after 1m0s
[00:24:37.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:9:0)
[00:24:37.119] Timer tick, asking Buildbucket for the build status
[00:24:37.300] Build 8913891760244443760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:37.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:10:0) after 1m0s
[00:24:46.756] Received PubSub notification, asking Buildbucket for the build status
[00:24:48.624] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:37.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:10:0)
[00:25:37.308] Timer tick, asking Buildbucket for the build status
[00:25:38.252] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:38.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:12:0) after 1m0s
[00:26:38.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:12:0)
[00:26:38.234] Timer tick, asking Buildbucket for the build status
[00:26:40.666] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:40.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:13:0) after 1m0s
[00:27:40.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:13:0)
[00:27:40.691] Timer tick, asking Buildbucket for the build status
[00:27:41.438] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:41.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:14:0) after 1m0s
[00:28:41.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:14:0)
[00:28:41.414] Timer tick, asking Buildbucket for the build status
[00:28:41.595] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:41.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:15:0) after 1m0s
[00:29:41.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:15:0)
[00:29:41.599] Timer tick, asking Buildbucket for the build status
[00:29:43.412] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:43.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:16:0) after 1m0s
[00:30:43.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:16:0)
[00:30:43.443] Timer tick, asking Buildbucket for the build status
[00:30:45.411] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:45.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:17:0) after 1m0s
[00:31:45.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:17:0)
[00:31:45.408] Timer tick, asking Buildbucket for the build status
[00:31:46.777] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:46.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:18:0) after 1m0s
[00:32:46.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:18:0)
[00:32:46.780] Timer tick, asking Buildbucket for the build status
[00:32:47.150] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:47.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:19:0) after 1m0s
[00:33:47.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:19:0)
[00:33:47.172] Timer tick, asking Buildbucket for the build status
[00:33:47.314] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:47.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:20:0) after 1m0s
[00:34:47.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:20:0)
[00:34:47.346] Timer tick, asking Buildbucket for the build status
[00:34:47.782] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:47.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:21:0) after 1m0s
[00:35:47.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:21:0)
[00:35:47.787] Timer tick, asking Buildbucket for the build status
[00:35:47.927] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:47.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:22:0) after 1m0s
[00:36:47.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:22:0)
[00:36:47.948] Timer tick, asking Buildbucket for the build status
[00:36:48.073] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:48.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:23:0) after 1m0s
[00:37:48.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:23:0)
[00:37:48.148] Timer tick, asking Buildbucket for the build status
[00:37:48.617] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:48.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:24:0) after 1m0s
[00:38:48.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:24:0)
[00:38:48.638] Timer tick, asking Buildbucket for the build status
[00:38:48.741] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:48.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:25:0) after 1m0s
[00:39:48.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:25:0)
[00:39:48.794] Timer tick, asking Buildbucket for the build status
[00:39:49.398] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:49.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:26:0) after 1m0s
[00:40:49.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:26:0)
[00:40:49.506] Timer tick, asking Buildbucket for the build status
[00:40:49.909] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:49.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:27:0) after 1m0s
[00:41:49.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:27:0)
[00:41:49.925] Timer tick, asking Buildbucket for the build status
[00:41:50.361] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:50.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:28:0) after 1m0s
[00:42:50.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:28:0)
[00:42:50.387] Timer tick, asking Buildbucket for the build status
[00:42:50.786] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:50.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:29:0) after 1m0s
[00:43:50.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:29:0)
[00:43:50.823] Timer tick, asking Buildbucket for the build status
[00:43:51.003] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:51.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:30:0) after 1m0s
[00:44:51.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:30:0)
[00:44:51.015] Timer tick, asking Buildbucket for the build status
[00:44:51.753] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:51.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:31:0) after 1m0s
[00:45:51.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:31:0)
[00:45:51.784] Timer tick, asking Buildbucket for the build status
[00:45:52.082] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:52.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:32:0) after 1m0s
[00:46:52.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:32:0)
[00:46:52.078] Timer tick, asking Buildbucket for the build status
[00:46:52.189] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:52.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:33:0) after 1m0s
[00:47:52.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:33:0)
[00:47:52.229] Timer tick, asking Buildbucket for the build status
[00:47:52.365] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:52.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:34:0) after 1m0s
[00:48:52.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:34:0)
[00:48:52.401] Timer tick, asking Buildbucket for the build status
[00:48:53.107] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:53.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:35:0) after 1m0s
[00:49:53.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:35:0)
[00:49:53.115] Timer tick, asking Buildbucket for the build status
[00:49:53.523] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:53.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:36:0) after 1m0s
[00:50:53.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:36:0)
[00:50:53.540] Timer tick, asking Buildbucket for the build status
[00:50:54.059] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:54.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:37:0) after 1m0s
[00:51:54.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:37:0)
[00:51:54.055] Timer tick, asking Buildbucket for the build status
[00:51:54.259] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:54.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:38:0) after 1m0s
[00:52:54.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:38:0)
[00:52:54.295] Timer tick, asking Buildbucket for the build status
[00:52:57.009] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:57.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:39:0) after 1m0s
[00:53:57.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:39:0)
[00:53:57.034] Timer tick, asking Buildbucket for the build status
[00:53:57.170] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:57.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:40:0) after 1m0s
[00:54:57.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:40:0)
[00:54:57.251] Timer tick, asking Buildbucket for the build status
[00:54:58.175] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:58.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:41:0) after 1m0s
[00:55:58.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:41:0)
[00:55:58.321] Timer tick, asking Buildbucket for the build status
[00:56:00.728] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:00.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:42:0) after 1m0s
[00:57:00.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:42:0)
[00:57:00.750] Timer tick, asking Buildbucket for the build status
[00:57:00.966] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:00.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:43:0) after 1m0s
[00:58:00.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:43:0)
[00:58:00.997] Timer tick, asking Buildbucket for the build status
[00:58:01.165] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:01.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:44:0) after 1m0s
[00:59:01.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:44:0)
[00:59:01.196] Timer tick, asking Buildbucket for the build status
[00:59:02.282] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:02.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:45:0) after 1m0s
[01:00:02.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:45:0)
[01:00:02.309] Timer tick, asking Buildbucket for the build status
[01:00:02.636] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:02.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:46:0) after 1m0s
[01:01:02.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:46:0)
[01:01:02.670] Timer tick, asking Buildbucket for the build status
[01:01:02.960] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:02.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:47:0) after 1m0s
[01:02:02.991] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:47:0)
[01:02:02.991] Timer tick, asking Buildbucket for the build status
[01:02:03.137] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:03.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:48:0) after 1m0s
[01:03:03.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:48:0)
[01:03:03.166] Timer tick, asking Buildbucket for the build status
[01:03:03.639] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:03.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:49:0) after 1m0s
[01:04:03.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:49:0)
[01:04:03.660] Timer tick, asking Buildbucket for the build status
[01:04:06.615] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:06.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:50:0) after 1m0s
[01:05:06.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:50:0)
[01:05:06.615] Timer tick, asking Buildbucket for the build status
[01:05:08.218] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:08.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:51:0) after 1m0s
[01:06:08.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:51:0)
[01:06:08.244] Timer tick, asking Buildbucket for the build status
[01:06:09.423] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:09.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:52:0) after 1m0s
[01:07:09.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:52:0)
[01:07:09.447] Timer tick, asking Buildbucket for the build status
[01:07:10.187] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:10.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:53:0) after 1m0s
[01:08:10.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:53:0)
[01:08:10.320] Timer tick, asking Buildbucket for the build status
[01:08:10.567] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:10.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:54:0) after 1m0s
[01:09:10.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:54:0)
[01:09:10.579] Timer tick, asking Buildbucket for the build status
[01:09:10.908] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:10.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:55:0) after 1m0s
[01:10:10.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:55:0)
[01:10:10.942] Timer tick, asking Buildbucket for the build status
[01:10:11.176] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:11.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:56:0) after 1m0s
[01:11:11.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:56:0)
[01:11:11.201] Timer tick, asking Buildbucket for the build status
[01:11:11.582] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:11.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:57:0) after 1m0s
[01:12:11.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:57:0)
[01:12:11.617] Timer tick, asking Buildbucket for the build status
[01:12:11.876] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:11.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:58:0) after 1m0s
[01:13:11.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:58:0)
[01:13:11.901] Timer tick, asking Buildbucket for the build status
[01:13:13.877] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:13.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:59:0) after 1m0s
[01:14:13.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:59:0)
[01:14:13.920] Timer tick, asking Buildbucket for the build status
[01:14:14.136] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:14.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:60:0) after 1m0s
[01:15:14.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:60:0)
[01:15:14.266] Timer tick, asking Buildbucket for the build status
[01:15:17.700] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:17.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:61:0) after 1m0s
[01:16:17.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:61:0)
[01:16:17.740] Timer tick, asking Buildbucket for the build status
[01:16:18.185] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:18.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:62:0) after 1m0s
[01:17:18.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:62:0)
[01:17:18.215] Timer tick, asking Buildbucket for the build status
[01:17:18.879] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:18.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:63:0) after 1m0s
[01:18:19.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:63:0)
[01:18:19.007] Timer tick, asking Buildbucket for the build status
[01:18:19.269] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:19.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:64:0) after 1m0s
[01:19:19.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:64:0)
[01:19:19.331] Timer tick, asking Buildbucket for the build status
[01:19:20.234] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:20.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:65:0) after 1m0s
[01:20:20.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:65:0)
[01:20:20.314] Timer tick, asking Buildbucket for the build status
[01:20:21.464] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:21.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:66:0) after 1m0s
[01:21:21.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:66:0)
[01:21:21.453] Timer tick, asking Buildbucket for the build status
[01:21:22.387] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:22.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:67:0) after 1m0s
[01:22:22.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:67:0)
[01:22:22.427] Timer tick, asking Buildbucket for the build status
[01:22:23.368] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:23.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:68:0) after 1m0s
[01:23:23.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:68:0)
[01:23:23.463] Timer tick, asking Buildbucket for the build status
[01:23:23.894] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:23.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:69:0) after 1m0s
[01:24:23.991] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:69:0)
[01:24:23.991] Timer tick, asking Buildbucket for the build status
[01:24:24.177] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:24.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:70:0) after 1m0s
[01:25:24.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:70:0)
[01:25:24.274] Timer tick, asking Buildbucket for the build status
[01:25:26.434] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:26.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:71:0) after 1m0s
[01:26:26.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:71:0)
[01:26:26.447] Timer tick, asking Buildbucket for the build status
[01:26:28.759] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:28.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:72:0) after 1m0s
[01:27:28.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:72:0)
[01:27:28.821] Timer tick, asking Buildbucket for the build status
[01:27:29.871] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:29.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:73:0) after 1m0s
[01:28:29.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:73:0)
[01:28:29.940] Timer tick, asking Buildbucket for the build status
[01:28:30.161] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:30.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:74:0) after 1m0s
[01:29:30.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:74:0)
[01:29:30.295] Timer tick, asking Buildbucket for the build status
[01:29:30.554] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:30.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:75:0) after 1m0s
[01:30:30.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:75:0)
[01:30:30.573] Timer tick, asking Buildbucket for the build status
[01:30:30.996] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:30.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:76:0) after 1m0s
[01:31:31.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:76:0)
[01:31:31.011] Timer tick, asking Buildbucket for the build status
[01:31:32.753] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:32.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:77:0) after 1m0s
[01:32:32.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:77:0)
[01:32:32.935] Timer tick, asking Buildbucket for the build status
[01:32:33.163] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:33.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:78:0) after 1m0s
[01:33:33.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:78:0)
[01:33:33.159] Timer tick, asking Buildbucket for the build status
[01:33:33.877] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:33.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:79:0) after 1m0s
[01:34:33.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:79:0)
[01:34:33.907] Timer tick, asking Buildbucket for the build status
[01:34:35.459] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:35.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:80:0) after 1m0s
[01:35:35.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:80:0)
[01:35:35.496] Timer tick, asking Buildbucket for the build status
[01:35:35.774] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:35.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:81:0) after 1m0s
[01:36:35.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:81:0)
[01:36:35.805] Timer tick, asking Buildbucket for the build status
[01:36:36.072] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:36.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:82:0) after 1m0s
[01:37:36.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:82:0)
[01:37:36.055] Timer tick, asking Buildbucket for the build status
[01:37:36.315] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:36.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:83:0) after 1m0s
[01:38:36.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:83:0)
[01:38:36.305] Timer tick, asking Buildbucket for the build status
[01:38:37.780] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:37.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:84:0) after 1m0s
[01:39:37.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:84:0)
[01:39:37.765] Timer tick, asking Buildbucket for the build status
[01:39:38.059] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:38.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:85:0) after 1m0s
[01:40:38.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:85:0)
[01:40:38.061] Timer tick, asking Buildbucket for the build status
[01:40:39.808] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:39.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:86:0) after 1m0s
[01:41:39.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:86:0)
[01:41:39.908] Timer tick, asking Buildbucket for the build status
[01:41:41.199] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:41.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:87:0) after 1m0s
[01:42:41.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:87:0)
[01:42:41.242] Timer tick, asking Buildbucket for the build status
[01:42:41.482] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:41.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:88:0) after 1m0s
[01:43:41.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:88:0)
[01:43:41.492] Timer tick, asking Buildbucket for the build status
[01:43:43.633] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:43.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:89:0) after 1m0s
[01:44:43.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:89:0)
[01:44:43.645] Timer tick, asking Buildbucket for the build status
[01:44:45.075] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:45.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:90:0) after 1m0s
[01:45:45.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:90:0)
[01:45:45.118] Timer tick, asking Buildbucket for the build status
[01:45:45.363] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:45.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:91:0) after 1m0s
[01:46:45.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:91:0)
[01:46:45.395] Timer tick, asking Buildbucket for the build status
[01:46:45.957] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:45.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:92:0) after 1m0s
[01:47:45.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:92:0)
[01:47:45.947] Timer tick, asking Buildbucket for the build status
[01:47:46.132] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:46.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:93:0) after 1m0s
[01:48:46.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:93:0)
[01:48:46.164] Timer tick, asking Buildbucket for the build status
[01:48:48.676] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:48.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:94:0) after 1m0s
[01:49:48.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:94:0)
[01:49:48.683] Timer tick, asking Buildbucket for the build status
[01:49:50.406] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:50.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:95:0) after 1m0s
[01:50:50.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:95:0)
[01:50:50.440] Timer tick, asking Buildbucket for the build status
[01:50:50.624] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:50.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:96:0) after 1m0s
[01:51:50.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:96:0)
[01:51:50.665] Timer tick, asking Buildbucket for the build status
[01:51:50.799] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:50.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:97:0) after 1m0s
[01:52:50.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:97:0)
[01:52:50.857] Timer tick, asking Buildbucket for the build status
[01:52:51.581] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:51.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:98:0) after 1m0s
[01:53:51.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:98:0)
[01:53:51.607] Timer tick, asking Buildbucket for the build status
[01:53:51.809] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:51.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:99:0) after 1m0s
[01:54:51.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:99:0)
[01:54:51.832] Timer tick, asking Buildbucket for the build status
[01:54:53.801] Build 8913891760244443760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:53.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079321828162705920:100:0) after 1m0s
[01:55:52.581] Received PubSub notification, asking Buildbucket for the build status
[01:55:53.060] Build 8913891760244443760: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[01:55:53.060] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1557453351565011",
"created_by": "project:chromium",
"created_ts": "1557447391237741",
"failure_reason": "BUILD_FAILURE",
"id": "8913891760244443760",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b33fa5bead85d5d70e527831033d942347badf2b\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"5 tests failed: ['non_network_service_browser_tests', 'non_network_service_interactive_ui_tests', 'viz_browser_tests', 'interactive_ui_tests', 'browser_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\": 12303, \"got_angle_revision\": \"cd078c3392560dd9712a4d4b91a05c1111b26f66\", \"got_dawn_revision\": \"974a1503273543719df2a3a18a967a4a785d49f1\", \"got_nacl_revision\": \"ca374f5112fca6b36fc5d73e117a60b82f394993\", \"got_revision\": \"b33fa5bead85d5d70e527831033d942347badf2b\", \"got_revision_cp\": \"refs/heads/master@{#658356}\", \"got_swarming_client_revision\": \"1b65f4e862045f3ba430a4cbd0643f5b1b66c230\", \"got_v8_revision\": \"a74147972b6713fbd1d99ebd789dfef29067281c\", \"got_v8_revision_cp\": \"refs/heads/7.6.141@{#1}\", \"got_webrtc_revision\": \"bf47f340ee2e11d297f6dc14f5d76abbe7c9a1e2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27891}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b33fa5bead85d5d70e527831033d942347badf2b\", \"swarm_hashes\": {\"accessibility_unittests\": \"b8282084379d3ed1cd6e6ed2263896d1522cd758\", \"angle_unittests\": \"17023a9ac01e034ca99f73a2bb3f1c7bdcd0d4bc\", \"app_list_unittests\": \"3a47c48fcbe92f83cefeda773d0eecdb905d8afa\", \"app_shell_unittests\": \"9ba7d4bc0b15cf0d6e50442ce7a1e9715724642d\", \"ash_unittests\": \"e490908954941a3114d3fbc1fae0cd0ad13fa74f\", \"aura_unittests\": \"050aa5fc4f7903eacc80924bf96034681c2b49c4\", \"base_unittests\": \"d822dcb861bf87305d2fa286efd37acd58be62db\", \"base_util_unittests\": \"677e7c2e564d076c930df8693c66a32ed9aba390\", \"blink_common_unittests\": \"a166fa6d8e1ea763ce4a00a96b7be4d3f2266953\", \"blink_fuzzer_unittests\": \"9a69bfa8a6797adfcfb099fc81d6baa634f3c2c4\", \"blink_heap_unittests\": \"c4f8f8e46151107dce8d7601e13e322666791920\", \"blink_platform_unittests\": \"97db789f08664d9c538786fbd683303d78e4b280\", \"blink_unittests\": \"020d381ace862fb8c55c804d2bf2a78fa55412f7\", \"boringssl_crypto_tests\": \"93ac1ec59819613fb483decc22a10983f72defa6\", \"boringssl_ssl_tests\": \"342ef97e943175a24a9793728a32441cc8531cb7\", \"browser_tests\": \"170ddee6c6d384edcb117ffcada87eac86d8a724\", \"cacheinvalidation_unittests\": \"35df50917360c53e3d786ddc2b643aeadb129b2c\", \"capture_unittests\": \"0245152b602b071fea914c6dc95a8003ce6f43af\", \"cast_unittests\": \"cafecc8f0f943a0d81ebf9d573b95f2f5c7ceae1\", \"cc_unittests\": \"acb86a38e48ddf0b13ae71cb37e502789c805fc9\", \"chrome_app_unittests\": \"6f86774fe97191f8e5366e97201db2f9526cfc4b\", \"chromedriver_unittests\": \"abf714ec0ed32361c62b4443d79cc6df65d3b942\", \"chromeos_components_unittests\": \"008b907537f8c065d123fefe156abcc21b3866bd\", \"chromeos_unittests\": \"21cf82d3e5c979f245b0d1a189ce43d286f5157b\", \"components_browsertests\": \"bb9bd277ef249f8accb3e9e31d15254472e7c528\", \"components_unittests\": \"0a53174842026362c7095e2aed8ed5db053ad3bd\", \"compositor_unittests\": \"19a4b750eb9b7d0e748353020a7280f0e1da72ad\", \"content_browsertests\": \"e46c7c3d910dea22f827c9d18c4f7c9ed070ba07\", \"content_unittests\": \"5859b10779a14ef3a68091398596d307122d5bdc\", \"crypto_unittests\": \"c55e1a537fa54db0a83fa87f125b298a0bfa22e9\", \"dbus_unittests\": \"a7ce98db68ecc4632522fcf94a5ab4ff51126bbb\", \"device_unittests\": \"0ae2b442cdabe3f1074b97ea2a61e51e55104a99\", \"display_unittests\": \"e2a6a368bc4017f14675887fff580047f28429b9\", \"events_unittests\": \"fdc3b7a8c470bb9a01b4f136a4aaf85d3ad24813\", \"exo_unittests\": \"5dc2cd033d4c781c0ea60d2b77472e48ba8e3488\", \"extensions_browsertests\": \"f82133a11d8174886591cb1f218d039b877e4080\", \"extensions_unittests\": \"a6c11b175e7232edb2338704ba1147d94832e532\", \"filesystem_service_unittests\": \"afb26c2206bf515e036d386722da6bb63e29f9d1\", \"gcm_unit_tests\": \"f42293529cfef02d1bdd1f28dbd0a06ed0744c7f\", \"gfx_unittests\": \"e6907dfa8b6e50504a27db071daaad378b42c63a\", \"gin_unittests\": \"1af78b6c58827bc5059009fbb66fd6419b67110e\", \"gl_unittests_ozone\": \"72c7a53bd94596dadb8815ffee123be6e2c90ecf\", \"google_apis_unittests\": \"9bc0f8bde0fc96f574cd3f03bd79aa0b37f1aa13\", \"gpu_unittests\": \"b70bd12c237aa362d103edca6d3a9d0f7eb5769f\", \"interactive_ui_tests\": \"7621158029ce349f975039b760e1837b431c980c\", \"ipc_tests\": \"de9b2d1d52efe6020697457ec4048564bb0eb143\", \"jingle_unittests\": \"dce9e28bdeff571be67103214c13c912f6f59a2e\", \"keyboard_unittests\": \"1bf6f8ef0a020fffd435912ac25a43f96770c685\", \"latency_unittests\": \"9456dc0ac91b270918bd84d40fe9fbc29f1fa8ec\", \"leveldb_service_unittests\": \"dbd435b35c58f0c4b2ccff9746b9096c6b2874ba\", \"libjingle_xmpp_unittests\": \"8e34de220da446b3d2f9c25a43e0bf3042618938\", \"media_blink_unittests\": \"bee7d63d0fc40591555d328408889694d7ddcc80\", \"media_service_unittests\": \"8afff99c3d1366837c235654d69ae58d1314634a\", \"media_unittests\": \"7e32c0a4021e588cec28d4e1da673420a2b79595\", \"message_center_unittests\": \"e0fc4b09dddde424816a9dcb23000f7ac816754d\", \"midi_unittests\": \"c78cf918141c4336ed68700939a3f6b554da70fd\", \"mojo_core_unittests\": \"d3ef4330c57c860574a712be58f820a22f60ce5f\", \"mojo_unittests\": \"7826848ad60343afacced8bf8d2c79bade81d364\", \"nacl_helper_nonsfi_unittests\": \"ea4bea308c659e48a57eb282be2e85daff17322d\", \"nacl_loader_unittests\": \"68b486d3ea68c1f0610318f1e1c87cf1d471d34f\", \"native_theme_unittests\": \"6d9179222d69fe6a1887ca43c3b0dbb723c84c86\", \"net_unittests\": \"b001cf970c3563a5c0734da78011904a3ce5c1c6\", \"ozone_gl_unittests\": \"5afe673355fa49cd44c6297c3f68ce1dcb312494\", \"ozone_unittests\": \"b779a418277d1ec2ede343186c9cd4956c4f7468\", \"ozone_x11_unittests\": \"c1d55a22d22f88bfa3572ec165123f7ad8e0d068\", \"pdf_unittests\": \"45b2aef8dc36e6bb531bbdfbaa81779287d8cf21\", \"perfetto_unittests\": \"d4624f0743da4ebca0d1554aaf5373c9629b5f14\", \"ppapi_unittests\": \"db0946fb14852d681848cae08f510a67b05c9240\", \"printing_unittests\": \"a7eefd6d4b43314dbbf45325e9474d59f16d6d4c\", \"remoting_unittests\": \"b0baaae5cca1bc401f1fa60f6c23f19fc3013055\", \"sandbox_linux_unittests\": \"2cacc386a2594d6c52d2e3d5cbff0d5e4c05abad\", \"service_manager_unittests\": \"8e8ffb9aa6b9fa22a8bca50a15c6126d6d4d6536\", \"services_unittests\": \"6495aea8a3cbf6f659a5c07fe4a2537005da326b\", \"shell_dialogs_unittests\": \"166218ebbab855bdf9735f675d37615d7a0770a0\", \"skia_unittests\": \"08104d69d2fe55af30156514388bb6f5ff09aa9c\", \"snapshot_unittests\": \"827270e561619f3f8317728936153edf7111901b\", \"sql_unittests\": \"b302c6d9c6ca777216142f9f13f01bc5ca579aa4\", \"storage_unittests\": \"92070efdf0bc2eeb88003a90bb78381e7e91326a\", \"sync_integration_tests\": \"c0d2560abe768d5a9ca5b09da78822785899da4a\", \"traffic_annotation_auditor_unittests\": \"7a78cf3918812898fdc8482bdf25867b44e21588\", \"ui_base_unittests\": \"9401cb9b4ffa1d4b29de1359e74a3418b78361d0\", \"ui_chromeos_unittests\": \"64c4531f9b805afc87f7cd870fbb9cd3855e951e\", \"ui_touch_selection_unittests\": \"2513a1e55f28ca07c916539d485918f9e367bb27\", \"unit_tests\": \"b56283cc09ae0e6fa8f18857b7c0bcd9b9144674\", \"url_unittests\": \"f17a0c0d44ca81a4a3939f10ec8fa75e906b6685\", \"usage_time_limit_unittests\": \"007946d9e7599faef1cc46d077c502a0320e701e\", \"views_unittests\": \"6b0858eb1121fe821852445f6caf2e8cc93795b2\", \"viz_unittests\": \"6ce75be512ef1f401b998f49460317ae67cb6747\", \"wm_unittests\": \"c94a9330cb9bef5ea15d44eb26170e2ea73f6432\", \"wtf_unittests\": \"989758645d32855239f966ac97cd875b1b110668\"}, \"swarm_hashes_refs/heads/master(at){#658356}_without_patch\": {\"accessibility_unittests\": \"b8282084379d3ed1cd6e6ed2263896d1522cd758\", \"angle_unittests\": \"17023a9ac01e034ca99f73a2bb3f1c7bdcd0d4bc\", \"app_list_unittests\": \"3a47c48fcbe92f83cefeda773d0eecdb905d8afa\", \"app_shell_unittests\": \"9ba7d4bc0b15cf0d6e50442ce7a1e9715724642d\", \"ash_unittests\": \"e490908954941a3114d3fbc1fae0cd0ad13fa74f\", \"aura_unittests\": \"050aa5fc4f7903eacc80924bf96034681c2b49c4\", \"base_unittests\": \"d822dcb861bf87305d2fa286efd37acd58be62db\", \"base_util_unittests\": \"677e7c2e564d076c930df8693c66a32ed9aba390\", \"blink_common_unittests\": \"a166fa6d8e1ea763ce4a00a96b7be4d3f2266953\", \"blink_fuzzer_unittests\": \"9a69bfa8a6797adfcfb099fc81d6baa634f3c2c4\", \"blink_heap_unittests\": \"c4f8f8e46151107dce8d7601e13e322666791920\", \"blink_platform_unittests\": \"97db789f08664d9c538786fbd683303d78e4b280\", \"blink_unittests\": \"020d381ace862fb8c55c804d2bf2a78fa55412f7\", \"boringssl_crypto_tests\": \"93ac1ec59819613fb483decc22a10983f72defa6\", \"boringssl_ssl_tests\": \"342ef97e943175a24a9793728a32441cc8531cb7\", \"browser_tests\": \"170ddee6c6d384edcb117ffcada87eac86d8a724\", \"cacheinvalidation_unittests\": \"35df50917360c53e3d786ddc2b643aeadb129b2c\", \"capture_unittests\": \"0245152b602b071fea914c6dc95a8003ce6f43af\", \"cast_unittests\": \"cafecc8f0f943a0d81ebf9d573b95f2f5c7ceae1\", \"cc_unittests\": \"acb86a38e48ddf0b13ae71cb37e502789c805fc9\", \"chrome_app_unittests\": \"6f86774fe97191f8e5366e97201db2f9526cfc4b\", \"chromedriver_unittests\": \"abf714ec0ed32361c62b4443d79cc6df65d3b942\", \"chromeos_components_unittests\": \"008b907537f8c065d123fefe156abcc21b3866bd\", \"chromeos_unittests\": \"21cf82d3e5c979f245b0d1a189ce43d286f5157b\", \"components_browsertests\": \"bb9bd277ef249f8accb3e9e31d15254472e7c528\", \"components_unittests\": \"0a53174842026362c7095e2aed8ed5db053ad3bd\", \"compositor_unittests\": \"19a4b750eb9b7d0e748353020a7280f0e1da72ad\", \"content_browsertests\": \"e46c7c3d910dea22f827c9d18c4f7c9ed070ba07\", \"content_unittests\": \"5859b10779a14ef3a68091398596d307122d5bdc\", \"crypto_unittests\": \"c55e1a537fa54db0a83fa87f125b298a0bfa22e9\", \"dbus_unittests\": \"a7ce98db68ecc4632522fcf94a5ab4ff51126bbb\", \"device_unittests\": \"0ae2b442cdabe3f1074b97ea2a61e51e55104a99\", \"display_unittests\": \"e2a6a368bc4017f14675887fff580047f28429b9\", \"events_unittests\": \"fdc3b7a8c470bb9a01b4f136a4aaf85d3ad24813\", \"exo_unittests\": \"5dc2cd033d4c781c0ea60d2b77472e48ba8e3488\", \"extensions_browsertests\": \"f82133a11d8174886591cb1f218d039b877e4080\", \"extensions_unittests\": \"a6c11b175e7232edb2338704ba1147d94832e532\", \"filesystem_service_unittests\": \"afb26c2206bf515e036d386722da6bb63e29f9d1\", \"gcm_unit_tests\": \"f42293529cfef02d1bdd1f28dbd0a06ed0744c7f\", \"gfx_unittests\": \"e6907dfa8b6e50504a27db071daaad378b42c63a\", \"gin_unittests\": \"1af78b6c58827bc5059009fbb66fd6419b67110e\", \"gl_unittests_ozone\": \"72c7a53bd94596dadb8815ffee123be6e2c90ecf\", \"google_apis_unittests\": \"9bc0f8bde0fc96f574cd3f03bd79aa0b37f1aa13\", \"gpu_unittests\": \"b70bd12c237aa362d103edca6d3a9d0f7eb5769f\", \"interactive_ui_tests\": \"7621158029ce349f975039b760e1837b431c980c\", \"ipc_tests\": \"de9b2d1d52efe6020697457ec4048564bb0eb143\", \"jingle_unittests\": \"dce9e28bdeff571be67103214c13c912f6f59a2e\", \"keyboard_unittests\": \"1bf6f8ef0a020fffd435912ac25a43f96770c685\", \"latency_unittests\": \"9456dc0ac91b270918bd84d40fe9fbc29f1fa8ec\", \"leveldb_service_unittests\": \"dbd435b35c58f0c4b2ccff9746b9096c6b2874ba\", \"libjingle_xmpp_unittests\": \"8e34de220da446b3d2f9c25a43e0bf3042618938\", \"media_blink_unittests\": \"bee7d63d0fc40591555d328408889694d7ddcc80\", \"media_service_unittests\": \"8afff99c3d1366837c235654d69ae58d1314634a\", \"media_unittests\": \"7e32c0a4021e588cec28d4e1da673420a2b79595\", \"message_center_unittests\": \"e0fc4b09dddde424816a9dcb23000f7ac816754d\", \"midi_unittests\": \"c78cf918141c4336ed68700939a3f6b554da70fd\", \"mojo_core_unittests\": \"d3ef4330c57c860574a712be58f820a22f60ce5f\", \"mojo_unittests\": \"7826848ad60343afacced8bf8d2c79bade81d364\", \"nacl_helper_nonsfi_unittests\": \"ea4bea308c659e48a57eb282be2e85daff17322d\", \"nacl_loader_unittests\": \"68b486d3ea68c1f0610318f1e1c87cf1d471d34f\", \"native_theme_unittests\": \"6d9179222d69fe6a1887ca43c3b0dbb723c84c86\", \"net_unittests\": \"b001cf970c3563a5c0734da78011904a3ce5c1c6\", \"ozone_gl_unittests\": \"5afe673355fa49cd44c6297c3f68ce1dcb312494\", \"ozone_unittests\": \"b779a418277d1ec2ede343186c9cd4956c4f7468\", \"ozone_x11_unittests\": \"c1d55a22d22f88bfa3572ec165123f7ad8e0d068\", \"pdf_unittests\": \"45b2aef8dc36e6bb531bbdfbaa81779287d8cf21\", \"perfetto_unittests\": \"d4624f0743da4ebca0d1554aaf5373c9629b5f14\", \"ppapi_unittests\": \"db0946fb14852d681848cae08f510a67b05c9240\", \"printing_unittests\": \"a7eefd6d4b43314dbbf45325e9474d59f16d6d4c\", \"remoting_unittests\": \"b0baaae5cca1bc401f1fa60f6c23f19fc3013055\", \"sandbox_linux_unittests\": \"2cacc386a2594d6c52d2e3d5cbff0d5e4c05abad\", \"service_manager_unittests\": \"8e8ffb9aa6b9fa22a8bca50a15c6126d6d4d6536\", \"services_unittests\": \"6495aea8a3cbf6f659a5c07fe4a2537005da326b\", \"shell_dialogs_unittests\": \"166218ebbab855bdf9735f675d37615d7a0770a0\", \"skia_unittests\": \"08104d69d2fe55af30156514388bb6f5ff09aa9c\", \"snapshot_unittests\": \"827270e561619f3f8317728936153edf7111901b\", \"sql_unittests\": \"b302c6d9c6ca777216142f9f13f01bc5ca579aa4\", \"storage_unittests\": \"92070efdf0bc2eeb88003a90bb78381e7e91326a\", \"sync_integration_tests\": \"c0d2560abe768d5a9ca5b09da78822785899da4a\", \"traffic_annotation_auditor_unittests\": \"7a78cf3918812898fdc8482bdf25867b44e21588\", \"ui_base_unittests\": \"9401cb9b4ffa1d4b29de1359e74a3418b78361d0\", \"ui_chromeos_unittests\": \"64c4531f9b805afc87f7cd870fbb9cd3855e951e\", \"ui_touch_selection_unittests\": \"2513a1e55f28ca07c916539d485918f9e367bb27\", \"unit_tests\": \"b56283cc09ae0e6fa8f18857b7c0bcd9b9144674\", \"url_unittests\": \"f17a0c0d44ca81a4a3939f10ec8fa75e906b6685\", \"usage_time_limit_unittests\": \"007946d9e7599faef1cc46d077c502a0320e701e\", \"views_unittests\": \"6b0858eb1121fe821852445f6caf2e8cc93795b2\", \"viz_unittests\": \"6ce75be512ef1f401b998f49460317ae67cb6747\", \"wm_unittests\": \"c94a9330cb9bef5ea15d44eb26170e2ea73f6432\", \"wtf_unittests\": \"989758645d32855239f966ac97cd875b1b110668\"}}, \"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\": [\"4292-d8c05fa\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"5 tests failed: ['non_network_service_browser_tests', 'non_network_service_interactive_ui_tests', 'viz_browser_tests', 'interactive_ui_tests', 'browser_tests']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1557447885770439",
"status": "COMPLETED",
"status_changed_ts": "1557447886364833",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12303",
"builder:linux-chromeos-dbg",
"buildset:commit/git/b33fa5bead85d5d70e527831033d942347badf2b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b33fa5bead85d5d70e527831033d942347badf2b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9079321828162705920",
"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/8913891760244443760/+/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:44b7eac50d60a310",
"user_agent:luci-scheduler"
],
"updated_ts": "1557453352129423",
"url": "https://ci.chromium.org/b/8913891760244443760",
"utcnow_ts": "1557453353037783"
}
}
[01:55:53.060] Invocation finished in 1h39m28.757952142s with status FAILED