[02:11:02.698] New invocation is queued and will start shortly
[02:11:04.434] Starting the invocation (attempt 1)
[02:11:04.471] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:11:04.471] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:11:04.471] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026405987280005200",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c69bf65e96004fc639822762e038344009688d9b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9026405987280005200",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/c69bf65e96004fc639822762e038344009688d9b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c69bf65e96004fc639822762e038344009688d9b",
"gitiles_ref:refs/heads/master"
]
}
[02:11:05.077] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607911864560347",
"id": "8860975924665731664",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c69bf65e96004fc639822762e038344009688d9b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607911864948814",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21735",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c69bf65e96004fc639822762e038344009688d9b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c69bf65e96004fc639822762e038344009688d9b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026405987280005200",
"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/8860975924665731664/+/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": "1607911864948936",
"url": "https://ci.chromium.org/b/8860975924665731664",
"utcnow_ts": "1607911865068392"
}
}
[02:11:05.077] Task URL: https://ci.chromium.org/b/8860975924665731664
[02:11:05.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:2:0) after 1m0s
[02:12:05.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:2:0)
[02:12:05.076] Timer tick, asking Buildbucket for the build status
[02:12:05.202] Build 8860975924665731664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:05.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:3:0) after 1m0s
[02:13:05.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:3:0)
[02:13:05.288] Timer tick, asking Buildbucket for the build status
[02:13:05.391] Build 8860975924665731664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:05.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:4:0) after 1m0s
[02:14:05.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:4:0)
[02:14:05.399] Timer tick, asking Buildbucket for the build status
[02:14:05.488] Build 8860975924665731664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:05.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:5:0) after 1m0s
[02:15:05.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:5:0)
[02:15:05.518] Timer tick, asking Buildbucket for the build status
[02:15:05.947] Build 8860975924665731664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:05.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:6:0) after 1m0s
[02:16:06.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:6:0)
[02:16:06.002] Timer tick, asking Buildbucket for the build status
[02:16:06.071] Build 8860975924665731664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:06.071] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:7:0) after 1m0s
[02:16:06.329] Received PubSub notification, asking Buildbucket for the build status
[02:16:06.469] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:06.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:7:0)
[02:17:06.065] Timer tick, asking Buildbucket for the build status
[02:17:06.175] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:06.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:9:0) after 1m0s
[02:18:06.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:9:0)
[02:18:06.205] Timer tick, asking Buildbucket for the build status
[02:18:06.315] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:06.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:10:0) after 1m0s
[02:19:06.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:10:0)
[02:19:06.433] Timer tick, asking Buildbucket for the build status
[02:19:06.493] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:06.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:11:0) after 1m0s
[02:20:06.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:11:0)
[02:20:06.583] Timer tick, asking Buildbucket for the build status
[02:20:06.652] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:06.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:12:0) after 1m0s
[02:21:06.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:12:0)
[02:21:06.662] Timer tick, asking Buildbucket for the build status
[02:21:06.764] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:06.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:13:0) after 1m0s
[02:22:06.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:13:0)
[02:22:06.792] Timer tick, asking Buildbucket for the build status
[02:22:06.855] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:06.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:14:0) after 1m0s
[02:23:06.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:14:0)
[02:23:06.853] Timer tick, asking Buildbucket for the build status
[02:23:06.916] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:06.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:15:0) after 1m0s
[02:24:06.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:15:0)
[02:24:06.926] Timer tick, asking Buildbucket for the build status
[02:24:07.009] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:07.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:16:0) after 1m0s
[02:25:07.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:16:0)
[02:25:07.032] Timer tick, asking Buildbucket for the build status
[02:25:07.098] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:07.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:17:0) after 1m0s
[02:26:07.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:17:0)
[02:26:07.114] Timer tick, asking Buildbucket for the build status
[02:26:07.724] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:07.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:18:0) after 1m0s
[02:27:07.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:18:0)
[02:27:07.744] Timer tick, asking Buildbucket for the build status
[02:27:08.047] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:08.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:19:0) after 1m0s
[02:28:08.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:19:0)
[02:28:08.068] Timer tick, asking Buildbucket for the build status
[02:28:08.600] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:08.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:20:0) after 1m0s
[02:29:08.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:20:0)
[02:29:08.616] Timer tick, asking Buildbucket for the build status
[02:29:09.003] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:09.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:21:0) after 1m0s
[02:30:09.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:21:0)
[02:30:09.022] Timer tick, asking Buildbucket for the build status
[02:30:09.199] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:09.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:22:0) after 1m0s
[02:31:09.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:22:0)
[02:31:09.230] Timer tick, asking Buildbucket for the build status
[02:31:09.613] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:09.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:23:0) after 1m0s
[02:32:09.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:23:0)
[02:32:09.636] Timer tick, asking Buildbucket for the build status
[02:32:09.838] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:09.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:24:0) after 1m0s
[02:33:09.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:24:0)
[02:33:09.864] Timer tick, asking Buildbucket for the build status
[02:33:09.941] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:09.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:25:0) after 1m0s
[02:34:09.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:25:0)
[02:34:09.992] Timer tick, asking Buildbucket for the build status
[02:34:10.072] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:10.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:26:0) after 1m0s
[02:35:10.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:26:0)
[02:35:10.092] Timer tick, asking Buildbucket for the build status
[02:35:10.228] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:10.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:27:0) after 1m0s
[02:36:10.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:27:0)
[02:36:10.276] Timer tick, asking Buildbucket for the build status
[02:36:10.405] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:10.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:28:0) after 1m0s
[02:37:10.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:28:0)
[02:37:10.443] Timer tick, asking Buildbucket for the build status
[02:37:10.504] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:10.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:29:0) after 1m0s
[02:38:10.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:29:0)
[02:38:10.520] Timer tick, asking Buildbucket for the build status
[02:38:10.582] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:10.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:30:0) after 1m0s
[02:39:10.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:30:0)
[02:39:10.603] Timer tick, asking Buildbucket for the build status
[02:39:10.669] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:10.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:31:0) after 1m0s
[02:40:10.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:31:0)
[02:40:10.685] Timer tick, asking Buildbucket for the build status
[02:40:10.779] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:10.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:32:0) after 1m0s
[02:41:10.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:32:0)
[02:41:10.802] Timer tick, asking Buildbucket for the build status
[02:41:10.924] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:10.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:33:0) after 1m0s
[02:42:10.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:33:0)
[02:42:10.970] Timer tick, asking Buildbucket for the build status
[02:42:11.154] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:11.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:34:0) after 1m0s
[02:43:11.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:34:0)
[02:43:11.182] Timer tick, asking Buildbucket for the build status
[02:43:11.245] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:11.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:35:0) after 1m0s
[02:44:11.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:35:0)
[02:44:11.265] Timer tick, asking Buildbucket for the build status
[02:44:12.551] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:12.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:36:0) after 1m0s
[02:45:12.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:36:0)
[02:45:12.619] Timer tick, asking Buildbucket for the build status
[02:45:12.678] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:12.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:37:0) after 1m0s
[02:46:12.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:37:0)
[02:46:12.781] Timer tick, asking Buildbucket for the build status
[02:46:12.889] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:12.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:38:0) after 1m0s
[02:47:13.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:38:0)
[02:47:13.018] Timer tick, asking Buildbucket for the build status
[02:47:15.255] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:15.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:39:0) after 1m0s
[02:48:15.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:39:0)
[02:48:15.343] Timer tick, asking Buildbucket for the build status
[02:48:15.405] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:15.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:40:0) after 1m0s
[02:49:15.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:40:0)
[02:49:15.520] Timer tick, asking Buildbucket for the build status
[02:49:15.588] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:15.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:41:0) after 1m0s
[02:50:15.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:41:0)
[02:50:15.697] Timer tick, asking Buildbucket for the build status
[02:50:15.760] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:15.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:42:0) after 1m0s
[02:51:15.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:42:0)
[02:51:15.825] Timer tick, asking Buildbucket for the build status
[02:51:15.991] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:15.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:43:0) after 1m0s
[02:52:16.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:43:0)
[02:52:16.036] Timer tick, asking Buildbucket for the build status
[02:52:16.099] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:16.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:44:0) after 1m0s
[02:53:16.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:44:0)
[02:53:16.119] Timer tick, asking Buildbucket for the build status
[02:53:16.175] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:16.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:45:0) after 1m0s
[02:54:16.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:45:0)
[02:54:16.194] Timer tick, asking Buildbucket for the build status
[02:54:16.409] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:16.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:46:0) after 1m0s
[02:55:16.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:46:0)
[02:55:16.426] Timer tick, asking Buildbucket for the build status
[02:55:16.519] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:16.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:47:0) after 1m0s
[02:56:16.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:47:0)
[02:56:16.576] Timer tick, asking Buildbucket for the build status
[02:56:16.679] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:16.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:48:0) after 1m0s
[02:57:16.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:48:0)
[02:57:16.712] Timer tick, asking Buildbucket for the build status
[02:57:16.776] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:16.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:49:0) after 1m0s
[02:58:16.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:49:0)
[02:58:16.944] Timer tick, asking Buildbucket for the build status
[02:58:17.097] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:17.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:50:0) after 1m0s
[02:59:17.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:50:0)
[02:59:17.122] Timer tick, asking Buildbucket for the build status
[02:59:17.251] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:17.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:51:0) after 1m0s
[03:00:17.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:51:0)
[03:00:17.384] Timer tick, asking Buildbucket for the build status
[03:00:17.487] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:17.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:52:0) after 1m0s
[03:01:17.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:52:0)
[03:01:17.500] Timer tick, asking Buildbucket for the build status
[03:01:17.627] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:17.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:53:0) after 1m0s
[03:02:17.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:53:0)
[03:02:17.753] Timer tick, asking Buildbucket for the build status
[03:02:18.107] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:18.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:54:0) after 1m0s
[03:03:18.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:54:0)
[03:03:18.227] Timer tick, asking Buildbucket for the build status
[03:03:18.399] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:18.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:55:0) after 1m0s
[03:04:18.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:55:0)
[03:04:18.431] Timer tick, asking Buildbucket for the build status
[03:04:18.560] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:18.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:56:0) after 1m0s
[03:05:18.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:56:0)
[03:05:18.566] Timer tick, asking Buildbucket for the build status
[03:05:18.699] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:18.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:57:0) after 1m0s
[03:06:18.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:57:0)
[03:06:18.757] Timer tick, asking Buildbucket for the build status
[03:06:19.430] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:19.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:58:0) after 1m0s
[03:07:19.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:58:0)
[03:07:19.460] Timer tick, asking Buildbucket for the build status
[03:07:19.644] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:19.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:59:0) after 1m0s
[03:08:19.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:59:0)
[03:08:19.664] Timer tick, asking Buildbucket for the build status
[03:08:19.838] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:19.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:60:0) after 1m0s
[03:09:19.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:60:0)
[03:09:19.858] Timer tick, asking Buildbucket for the build status
[03:09:19.978] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:19.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:61:0) after 1m0s
[03:10:19.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:61:0)
[03:10:19.982] Timer tick, asking Buildbucket for the build status
[03:10:20.292] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:20.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:62:0) after 1m0s
[03:11:20.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:62:0)
[03:11:20.309] Timer tick, asking Buildbucket for the build status
[03:11:20.519] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:20.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:63:0) after 1m0s
[03:12:20.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:63:0)
[03:12:20.540] Timer tick, asking Buildbucket for the build status
[03:12:20.624] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:20.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:64:0) after 1m0s
[03:13:20.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:64:0)
[03:13:20.669] Timer tick, asking Buildbucket for the build status
[03:13:20.744] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:20.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:65:0) after 1m0s
[03:14:20.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:65:0)
[03:14:20.761] Timer tick, asking Buildbucket for the build status
[03:14:20.855] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:20.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:66:0) after 1m0s
[03:15:20.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:66:0)
[03:15:20.848] Timer tick, asking Buildbucket for the build status
[03:15:20.921] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:20.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:67:0) after 1m0s
[03:16:20.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:67:0)
[03:16:20.967] Timer tick, asking Buildbucket for the build status
[03:16:21.069] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:21.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:68:0) after 1m0s
[03:17:21.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:68:0)
[03:17:21.088] Timer tick, asking Buildbucket for the build status
[03:17:21.232] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:21.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:69:0) after 1m0s
[03:18:21.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:69:0)
[03:18:21.227] Timer tick, asking Buildbucket for the build status
[03:18:21.338] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:21.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:70:0) after 1m0s
[03:19:21.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:70:0)
[03:19:21.603] Timer tick, asking Buildbucket for the build status
[03:19:21.709] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:21.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:71:0) after 1m0s
[03:20:21.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:71:0)
[03:20:21.800] Timer tick, asking Buildbucket for the build status
[03:20:21.872] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:21.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:72:0) after 1m0s
[03:21:21.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:72:0)
[03:21:21.885] Timer tick, asking Buildbucket for the build status
[03:21:22.019] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:22.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:73:0) after 1m0s
[03:22:22.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:73:0)
[03:22:22.116] Timer tick, asking Buildbucket for the build status
[03:22:22.242] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:22.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:74:0) after 1m0s
[03:23:22.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:74:0)
[03:23:22.292] Timer tick, asking Buildbucket for the build status
[03:23:22.701] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:22.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:75:0) after 1m0s
[03:24:22.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:75:0)
[03:24:22.836] Timer tick, asking Buildbucket for the build status
[03:24:23.497] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:23.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:76:0) after 1m0s
[03:25:23.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:76:0)
[03:25:23.550] Timer tick, asking Buildbucket for the build status
[03:25:23.679] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:23.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:77:0) after 1m0s
[03:26:23.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:77:0)
[03:26:23.783] Timer tick, asking Buildbucket for the build status
[03:26:23.902] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:23.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:78:0) after 1m0s
[03:27:24.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:78:0)
[03:27:24.019] Timer tick, asking Buildbucket for the build status
[03:27:24.209] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:24.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:79:0) after 1m0s
[03:28:24.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:79:0)
[03:28:24.272] Timer tick, asking Buildbucket for the build status
[03:28:24.397] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:24.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:80:0) after 1m0s
[03:29:24.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:80:0)
[03:29:24.446] Timer tick, asking Buildbucket for the build status
[03:29:24.534] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:24.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:81:0) after 1m0s
[03:30:24.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:81:0)
[03:30:24.599] Timer tick, asking Buildbucket for the build status
[03:30:25.130] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:25.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:82:0) after 1m0s
[03:31:25.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:82:0)
[03:31:25.152] Timer tick, asking Buildbucket for the build status
[03:31:25.391] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:25.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:83:0) after 1m0s
[03:32:25.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:83:0)
[03:32:25.423] Timer tick, asking Buildbucket for the build status
[03:32:25.509] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:25.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:84:0) after 1m0s
[03:33:25.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:84:0)
[03:33:25.559] Timer tick, asking Buildbucket for the build status
[03:33:25.634] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:25.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:85:0) after 1m0s
[03:34:25.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:85:0)
[03:34:25.688] Timer tick, asking Buildbucket for the build status
[03:34:25.760] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:25.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:86:0) after 1m0s
[03:35:25.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:86:0)
[03:35:25.784] Timer tick, asking Buildbucket for the build status
[03:35:26.061] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:26.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:87:0) after 1m0s
[03:36:26.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:87:0)
[03:36:26.110] Timer tick, asking Buildbucket for the build status
[03:36:26.623] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:26.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:88:0) after 1m0s
[03:37:26.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:88:0)
[03:37:26.640] Timer tick, asking Buildbucket for the build status
[03:37:26.716] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:26.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:89:0) after 1m0s
[03:38:26.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:89:0)
[03:38:26.768] Timer tick, asking Buildbucket for the build status
[03:38:26.843] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:26.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:90:0) after 1m0s
[03:39:26.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:90:0)
[03:39:26.814] Timer tick, asking Buildbucket for the build status
[03:39:26.879] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:26.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:91:0) after 1m0s
[03:40:26.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:91:0)
[03:40:26.900] Timer tick, asking Buildbucket for the build status
[03:40:27.231] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:27.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:92:0) after 1m0s
[03:41:27.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:92:0)
[03:41:27.250] Timer tick, asking Buildbucket for the build status
[03:41:27.453] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:27.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:93:0) after 1m0s
[03:42:27.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:93:0)
[03:42:27.471] Timer tick, asking Buildbucket for the build status
[03:42:27.613] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:27.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:94:0) after 1m0s
[03:43:27.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:94:0)
[03:43:27.631] Timer tick, asking Buildbucket for the build status
[03:43:27.759] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:27.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:95:0) after 1m0s
[03:44:27.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:95:0)
[03:44:27.780] Timer tick, asking Buildbucket for the build status
[03:44:27.926] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:27.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:96:0) after 1m0s
[03:45:27.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:96:0)
[03:45:27.956] Timer tick, asking Buildbucket for the build status
[03:45:28.034] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:28.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:97:0) after 1m0s
[03:46:28.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:97:0)
[03:46:28.041] Timer tick, asking Buildbucket for the build status
[03:46:28.162] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:28.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:98:0) after 1m0s
[03:47:28.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:98:0)
[03:47:28.216] Timer tick, asking Buildbucket for the build status
[03:47:28.290] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:28.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:99:0) after 1m0s
[03:48:28.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:99:0)
[03:48:28.296] Timer tick, asking Buildbucket for the build status
[03:48:28.369] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:28.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:100:0) after 1m0s
[03:49:28.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:100:0)
[03:49:28.386] Timer tick, asking Buildbucket for the build status
[03:49:28.465] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:28.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:101:0) after 1m0s
[03:50:28.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:101:0)
[03:50:28.491] Timer tick, asking Buildbucket for the build status
[03:50:28.576] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:28.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:102:0) after 1m0s
[03:51:28.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:102:0)
[03:51:28.595] Timer tick, asking Buildbucket for the build status
[03:51:29.167] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:29.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:103:0) after 1m0s
[03:52:29.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:103:0)
[03:52:29.230] Timer tick, asking Buildbucket for the build status
[03:52:29.405] Build 8860975924665731664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:29.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026405987280005200:104:0) after 1m0s
[03:52:58.374] Received PubSub notification, asking Buildbucket for the build status
[03:52:58.491] Build 8860975924665731664: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[03:52:58.491] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607917975572773",
"created_by": "project:chromium",
"created_ts": "1607911864560347",
"failure_reason": "BUILD_FAILURE",
"id": "8860975924665731664",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c69bf65e96004fc639822762e038344009688d9b\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- PasswordManagerBackForwardCacheBrowserTest.SavePasswordOnRestoredPage\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"c69bf65e96004fc639822762e038344009688d9b\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-150-7x82\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21735, \"got_angle_revision\": \"da8c22614051f43cd4d44d6809eafb150310361a\", \"got_dawn_revision\": \"fb6c21547e6c5bc2053c15169769397e6584c9d2\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"c69bf65e96004fc639822762e038344009688d9b\", \"got_revision_cp\": \"refs/heads/master@{#836511}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"c16dc7107fd329b815c700b002d1ba40372b16dc\", \"got_v8_revision\": \"fdc632431816ab61fd53d15e4beec259eb07e6b6\", \"got_v8_revision_cp\": \"refs/heads/8.9.144@{#1}\", \"got_webrtc_revision\": \"d7808f1c464a07c8f1e2f97ec7ee92fda998d590\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32804}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c69bf65e96004fc639822762e038344009688d9b\", \"swarm_hashes_refs/heads/master(at){#836511}_without_patch\": {\"absl_hardening_tests\": \"3d98a7931552c97a2be053056c9068c82b29422a\", \"accessibility_unittests\": \"7972eb6259fa46b7344c71e5fdcec367daadfd01\", \"angle_unittests\": \"caccdfdbf4ea63e0b5b905ac7a19e9cf0777d3c4\", \"app_list_unittests\": \"e8b3c1e7eecc6dfb37f909bd4c4c7e23ec49956e\", \"app_shell_unittests\": \"e4d7383b4019945deda1cdedf3b2b8ae0a075029\", \"ash_unittests\": \"b41a7ed3b7d3882ed3154ab29c3509c6c17bc702\", \"aura_unittests\": \"ca5ac7126cef6b3deab68a542bb9619a2ca328dc\", \"base_unittests\": \"14ff044b8552b7f33b49b081b69874b7bbdeb0fa\", \"base_util_unittests\": \"35751627f05ce0b55c3ee608a14f307e36a7e681\", \"blink_common_unittests\": \"aaf4bcabb90b7cab482d3b8445161b7a83305184\", \"blink_fuzzer_unittests\": \"fce182ae91831032d90e5071a7c4ddc21e5fced5\", \"blink_heap_unittests\": \"8ef9eafbaf13a647fe5b9458568c0ee3795415d1\", \"blink_platform_unittests\": \"8a2c962fdae3d4169da18fa0a01bf0e57d94593f\", \"blink_unittests\": \"270cd8187e07cbbc6806f43dfb323b2d5bd6b12b\", \"boringssl_crypto_tests\": \"e98650c0faef1545381c8241bb88c81ead3cafc2\", \"boringssl_ssl_tests\": \"e94fb8c575ce66ec21ff9839996e4ad0e37170d9\", \"browser_tests\": \"d83f11842b05ea7b1973697030806962c9f575b0\", \"capture_unittests\": \"fadf538c16772ce649a8f41b9fc4aae3f04f3ffc\", \"cast_unittests\": \"e92772433172191a91acab9d6423f411c35a66de\", \"cc_unittests\": \"b035ed52aeb29b6f22722e1258134b2f073bc5d3\", \"chrome_app_unittests\": \"97479f02ee8182afd43eccdb9f62e45d018fd361\", \"chromedriver_unittests\": \"6648a4b0d8b26661f9747b4485e75a57d32200cb\", \"chromeos_components_unittests\": \"0fc0da25837f959930003f1a2a8ca3ee54d1273b\", \"chromeos_unittests\": \"8373a5dc698f69e0d88bb3bedcc7eac9128702c3\", \"components_browsertests\": \"83c573bf3f2fc25cd613fca1bff2c77c8a14e433\", \"components_unittests\": \"06ef53f442bc182821b865c951133570772d8339\", \"compositor_unittests\": \"695c525ae5f782ad00c34f2bc4aaba6dc3ae2781\", \"content_browsertests\": \"5b8408d18b83aec13ae8e3c6d93ef6933c31c403\", \"content_unittests\": \"05a23a6fceef845f5ee40f09cc672b1a6d150c69\", \"crashpad_tests\": \"1ad7d7d514706581108c85e91d51c5bf5157bd88\", \"crypto_unittests\": \"d88c93177aa30087fbaa16961e6e7e472c9a9d85\", \"dbus_unittests\": \"9492bae93dfcd58bc6190ce5558a806a7e3bd90f\", \"device_unittests\": \"fd9ef8a21d68906dfe1aa1c3e6c5895129c9cad1\", \"display_unittests\": \"0479ab1c5878ee616bf5d275c18b9ba1a37d91b1\", \"events_unittests\": \"44348ed53827c862d7358cf4f8c3827736b2831e\", \"exo_unittests\": \"d26f70ac9cfe8cdccfd3dbe29daa72421c819eec\", \"extensions_browsertests\": \"3ee8eb84f3d4ac1d2f0ec2da6fc870dac76d0731\", \"extensions_unittests\": \"a0a3c961ada080cb2bb851905dca47842ada01d1\", \"filesystem_service_unittests\": \"4e992359a19fb3c131c89f85a597a44866f942dd\", \"gcm_unit_tests\": \"f8904fddbf34bc612d44ffe7ca68f43acbcc6ea9\", \"gfx_unittests\": \"c23720a0bfa07558766a2d75eee4d73a0294faac\", \"gin_unittests\": \"6f1566f14e7c119a5984cfc5a32a0cad609516af\", \"gl_unittests_ozone\": \"c55e58848b8a29fa7306e08d2fad26358d765bdf\", \"google_apis_unittests\": \"717de0f9b374ce202f90efcd26bf89070ca62cf7\", \"gpu_unittests\": \"aef6e3d0f5e166e8383e07b5169068b9daaf24da\", \"gwp_asan_unittests\": \"6613f7a716602fd80826d3020620f63ed3eb258b\", \"interactive_ui_tests\": \"d5abad273266442aaea4346a88478a2cbf015756\", \"ipc_tests\": \"85f6046ff1ebf4c5524f914f531d5e02846c1606\", \"jingle_unittests\": \"c21804dc00a235c20f8bfa3d232550317c114548\", \"keyboard_unittests\": \"c35fb32604450d42ca8545046a78dcb69eb0f747\", \"latency_unittests\": \"bf8d18551ba3af37963d75bd543e873c5615e726\", \"libjingle_xmpp_unittests\": \"f454c6c9d38829dc83ddaf49f94ecc4b87c8abb5\", \"liburlpattern_unittests\": \"3492fbc09c855a4574df1965c95c8c547f84ac80\", \"media_blink_unittests\": \"7e5379544dc068e89d9e20b1233943c7c69e785f\", \"media_unittests\": \"feea86795ae1a7714d4b5d5d5f40809c9a8f67ad\", \"message_center_unittests\": \"e20994928a3058f8f84f754aefd29ab0183eb2c1\", \"midi_unittests\": \"7c70bec0506eafcdb18a92cd4fd0f7fa3c406001\", \"mojo_core_unittests\": \"1e3c4caff035a39f417a8f36ab328005e50875b6\", \"mojo_unittests\": \"839b580977b95542666768344c8ae38d1479cc36\", \"nacl_helper_nonsfi_unittests\": \"8729acfde2c804700271a02ee0e0dc65a4bcf2db\", \"nacl_loader_unittests\": \"f96182abe79dd6ea7e7ac9d853643708b2f13277\", \"native_theme_unittests\": \"5b23e102153a0a8c5139a6a5bf4d9a7c2ccc4c11\", \"net_unittests\": \"54e8080a5fc07a4f5cd9505994d2cb2e090360c4\", \"ozone_gl_unittests\": \"c4f535c5b7890f0889b29768977d7bc1af97ef37\", \"ozone_unittests\": \"8287bc766a95cb82350bf7290d343a0f0132445e\", \"ozone_x11_unittests\": \"0b897a99ec8a3a0c9a04070176d11828e91a4010\", \"pdf_unittests\": \"f40fe49ce95220fdbbeb202afbcfbaf0d33e1a61\", \"perfetto_unittests\": \"14b76f8b99f31601a57e22121d9c4dd7c7a1cb64\", \"ppapi_unittests\": \"ca9f7eed4be6e92ededbebd7d3d48a7a194378b0\", \"printing_unittests\": \"b63d573153fbebaed00ac88f15bfb0574adc7413\", \"remoting_unittests\": \"fdb85fe62799b17dc57941764ec7d3141c65ec06\", \"sandbox_linux_unittests\": \"352333b3d4d27a5370d197bd4a0a95989a73bd6f\", \"service_manager_unittests\": \"9735c4ea95047cd39b9f575bf6edb240cd61ca73\", \"services_unittests\": \"b85146dcd4e5f3f670c121773d192c6d208d7014\", \"shell_dialogs_unittests\": \"c5b358b3c1d04574469646f9684baac32ad50bd4\", \"shell_encryption_unittests\": \"6c3f3b6fdf9d8c204c6ef0028343082aa4e11ae7\", \"skia_unittests\": \"be6b9cd7672b61f56be2ef1c52a28874570f2f70\", \"snapshot_unittests\": \"04d984825497ab5940d5b37279410a2ace83bbbc\", \"sql_unittests\": \"d2ddc5fe45cd98e77cf51ebffec00aefcc9e9733\", \"storage_unittests\": \"c57570052b7b316228c63dfa84e2b472538b70e9\", \"sync_integration_tests\": \"0bdc038a780832a5f724afb14861feb056329acb\", \"traffic_annotation_auditor_unittests\": \"28b6f2f4db50a6bc8a9aea29b3981daf04225c97\", \"ui_base_unittests\": \"0316c2ac965a6283019e3507efab07ddefd84ba6\", \"ui_chromeos_unittests\": \"2ecc355c9f67ec0c4cda31a4749a1fd8f1f97c14\", \"ui_touch_selection_unittests\": \"6fb7f9e03f27341b4452375fa7298bf938e20ead\", \"unit_tests\": \"103f42d99ab777f06aa409bbdde654498b77d298\", \"url_unittests\": \"aff9bc35b94f3c2941395343ddf0b98750921cbe\", \"usage_time_limit_unittests\": \"a10b30cb78b1556ffc49b081f20f83af7d1a5cc6\", \"views_unittests\": \"4f431867afcc42ff4e9f85548b3e5ba9fc128e56\", \"viz_unittests\": \"715428d406d14d903c92baca3f3a473b350e1c4d\", \"wm_unittests\": \"aa3bd62f1c52c2ca542390051befd346b86fa57c\", \"wtf_unittests\": \"df39090674bbbb5763dc8c088f5886a15870c7bc\", \"zlib_unittests\": \"f33e8ba2833b71c4c7c0074f9dbac3f5e72d198a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-150-7x82\"], \"image\": [\"chrome-xenial-20120600-c5cfbe11ce8\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- PasswordManagerBackForwardCacheBrowserTest.SavePasswordOnRestoredPage\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607912165481539",
"status": "COMPLETED",
"status_changed_ts": "1607912166062181",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21735",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c69bf65e96004fc639822762e038344009688d9b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c69bf65e96004fc639822762e038344009688d9b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026405987280005200",
"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/8860975924665731664/+/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:5077d5850d182010",
"user_agent:luci-scheduler"
],
"updated_ts": "1607917977794003",
"url": "https://ci.chromium.org/b/8860975924665731664",
"utcnow_ts": "1607917978483354"
}
}
[03:52:58.491] Invocation finished in 1h41m55.808216786s with status FAILED