[04:30:30.672] New invocation is queued and will start shortly
[04:30:31.923] Starting the invocation (attempt 1)
[04:30:31.964] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:30:31.964] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:30:31.964] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031289449016423360",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4bdce889ea3596b1cf6c336cd8d17405c2822ad3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9031289449016423360",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/4bdce889ea3596b1cf6c336cd8d17405c2822ad3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4bdce889ea3596b1cf6c336cd8d17405c2822ad3",
"gitiles_ref:refs/heads/master"
]
}
[04:30:33.217] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603254632060848",
"id": "8865859386891147952",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4bdce889ea3596b1cf6c336cd8d17405c2822ad3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603254632764776",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20943",
"builder:linux-chromeos-dbg",
"buildset:commit/git/4bdce889ea3596b1cf6c336cd8d17405c2822ad3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4bdce889ea3596b1cf6c336cd8d17405c2822ad3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031289449016423360",
"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/8865859386891147952/+/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": "1603254632764980",
"url": "https://ci.chromium.org/b/8865859386891147952",
"utcnow_ts": "1603254633195244"
}
}
[04:30:33.218] Task URL: https://ci.chromium.org/b/8865859386891147952
[04:30:33.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:2:0) after 1m0s
[04:31:13.491] Received PubSub notification, asking Buildbucket for the build status
[04:31:13.572] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:33.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:2:0)
[04:31:33.236] Timer tick, asking Buildbucket for the build status
[04:31:33.346] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:33.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:4:0) after 1m0s
[04:32:33.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:4:0)
[04:32:33.411] Timer tick, asking Buildbucket for the build status
[04:32:34.023] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:34.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:5:0) after 1m0s
[04:33:34.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:5:0)
[04:33:34.045] Timer tick, asking Buildbucket for the build status
[04:33:34.098] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:34.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:6:0) after 1m0s
[04:34:34.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:6:0)
[04:34:34.177] Timer tick, asking Buildbucket for the build status
[04:34:34.298] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:34.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:7:0) after 1m0s
[04:35:34.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:7:0)
[04:35:34.397] Timer tick, asking Buildbucket for the build status
[04:35:34.887] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:34.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:8:0) after 1m0s
[04:36:34.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:8:0)
[04:36:34.955] Timer tick, asking Buildbucket for the build status
[04:36:35.294] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:35.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:9:0) after 1m0s
[04:37:35.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:9:0)
[04:37:35.321] Timer tick, asking Buildbucket for the build status
[04:37:35.426] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:35.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:10:0) after 1m0s
[04:38:35.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:10:0)
[04:38:35.408] Timer tick, asking Buildbucket for the build status
[04:38:35.569] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:35.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:11:0) after 1m0s
[04:39:35.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:11:0)
[04:39:35.602] Timer tick, asking Buildbucket for the build status
[04:39:35.660] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:35.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:12:0) after 1m0s
[04:40:35.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:12:0)
[04:40:35.686] Timer tick, asking Buildbucket for the build status
[04:40:35.846] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:35.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:13:0) after 1m0s
[04:41:35.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:13:0)
[04:41:35.926] Timer tick, asking Buildbucket for the build status
[04:41:36.001] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:36.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:14:0) after 1m0s
[04:42:36.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:14:0)
[04:42:36.050] Timer tick, asking Buildbucket for the build status
[04:42:36.344] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:36.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:15:0) after 1m0s
[04:43:36.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:15:0)
[04:43:36.412] Timer tick, asking Buildbucket for the build status
[04:43:36.600] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:36.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:16:0) after 1m0s
[04:44:36.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:16:0)
[04:44:36.587] Timer tick, asking Buildbucket for the build status
[04:44:36.660] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:36.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:17:0) after 1m0s
[04:45:36.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:17:0)
[04:45:36.727] Timer tick, asking Buildbucket for the build status
[04:45:36.902] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:36.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:18:0) after 1m0s
[04:46:36.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:18:0)
[04:46:36.957] Timer tick, asking Buildbucket for the build status
[04:46:37.068] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:37.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:19:0) after 1m0s
[04:47:37.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:19:0)
[04:47:37.129] Timer tick, asking Buildbucket for the build status
[04:47:37.195] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:37.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:20:0) after 1m0s
[04:48:37.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:20:0)
[04:48:37.301] Timer tick, asking Buildbucket for the build status
[04:48:37.365] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:37.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:21:0) after 1m0s
[04:49:37.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:21:0)
[04:49:37.350] Timer tick, asking Buildbucket for the build status
[04:49:37.414] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:37.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:22:0) after 1m0s
[04:50:37.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:22:0)
[04:50:37.510] Timer tick, asking Buildbucket for the build status
[04:50:38.168] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:38.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:23:0) after 1m0s
[04:51:38.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:23:0)
[04:51:38.236] Timer tick, asking Buildbucket for the build status
[04:51:38.307] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:38.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:24:0) after 1m0s
[04:52:38.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:24:0)
[04:52:38.384] Timer tick, asking Buildbucket for the build status
[04:52:38.554] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:38.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:25:0) after 1m0s
[04:53:38.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:25:0)
[04:53:38.564] Timer tick, asking Buildbucket for the build status
[04:53:38.625] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:38.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:26:0) after 1m0s
[04:54:38.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:26:0)
[04:54:38.665] Timer tick, asking Buildbucket for the build status
[04:54:38.729] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:38.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:27:0) after 1m0s
[04:55:38.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:27:0)
[04:55:38.711] Timer tick, asking Buildbucket for the build status
[04:55:38.815] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:38.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:28:0) after 1m0s
[04:56:38.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:28:0)
[04:56:38.937] Timer tick, asking Buildbucket for the build status
[04:56:39.006] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:39.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:29:0) after 1m0s
[04:57:39.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:29:0)
[04:57:39.052] Timer tick, asking Buildbucket for the build status
[04:57:39.114] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:39.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:30:0) after 1m0s
[04:58:39.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:30:0)
[04:58:39.233] Timer tick, asking Buildbucket for the build status
[04:58:39.371] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:39.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:31:0) after 1m0s
[04:59:39.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:31:0)
[04:59:39.429] Timer tick, asking Buildbucket for the build status
[04:59:39.525] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:39.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:32:0) after 1m0s
[05:00:39.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:32:0)
[05:00:39.891] Timer tick, asking Buildbucket for the build status
[05:00:40.046] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:40.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:33:0) after 1m0s
[05:01:40.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:33:0)
[05:01:40.179] Timer tick, asking Buildbucket for the build status
[05:01:40.259] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:40.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:34:0) after 1m0s
[05:02:40.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:34:0)
[05:02:40.314] Timer tick, asking Buildbucket for the build status
[05:02:40.413] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:40.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:35:0) after 1m0s
[05:03:40.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:35:0)
[05:03:40.505] Timer tick, asking Buildbucket for the build status
[05:03:40.574] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:40.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:36:0) after 1m0s
[05:04:40.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:36:0)
[05:04:40.558] Timer tick, asking Buildbucket for the build status
[05:04:41.523] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:41.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:37:0) after 1m0s
[05:05:41.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:37:0)
[05:05:41.558] Timer tick, asking Buildbucket for the build status
[05:05:41.653] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:41.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:38:0) after 1m0s
[05:06:41.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:38:0)
[05:06:41.721] Timer tick, asking Buildbucket for the build status
[05:06:41.781] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:41.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:39:0) after 1m0s
[05:07:41.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:39:0)
[05:07:41.805] Timer tick, asking Buildbucket for the build status
[05:07:41.923] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:41.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:40:0) after 1m0s
[05:08:41.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:40:0)
[05:08:41.942] Timer tick, asking Buildbucket for the build status
[05:08:42.193] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:42.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:41:0) after 1m0s
[05:09:42.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:41:0)
[05:09:42.217] Timer tick, asking Buildbucket for the build status
[05:09:42.277] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:42.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:42:0) after 1m0s
[05:10:42.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:42:0)
[05:10:42.305] Timer tick, asking Buildbucket for the build status
[05:10:42.413] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:42.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:43:0) after 1m0s
[05:11:42.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:43:0)
[05:11:42.456] Timer tick, asking Buildbucket for the build status
[05:11:42.709] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:42.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:44:0) after 1m0s
[05:12:42.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:44:0)
[05:12:42.803] Timer tick, asking Buildbucket for the build status
[05:12:43.129] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:43.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:45:0) after 1m0s
[05:13:43.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:45:0)
[05:13:43.162] Timer tick, asking Buildbucket for the build status
[05:13:43.237] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:43.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:46:0) after 1m0s
[05:14:43.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:46:0)
[05:14:43.264] Timer tick, asking Buildbucket for the build status
[05:14:43.330] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:43.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:47:0) after 1m0s
[05:15:43.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:47:0)
[05:15:43.358] Timer tick, asking Buildbucket for the build status
[05:15:43.467] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:43.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:48:0) after 1m0s
[05:16:43.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:48:0)
[05:16:43.491] Timer tick, asking Buildbucket for the build status
[05:16:43.639] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:43.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:49:0) after 1m0s
[05:17:43.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:49:0)
[05:17:43.672] Timer tick, asking Buildbucket for the build status
[05:17:44.016] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:44.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:50:0) after 1m0s
[05:18:44.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:50:0)
[05:18:44.024] Timer tick, asking Buildbucket for the build status
[05:18:44.158] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:44.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:51:0) after 1m0s
[05:19:44.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:51:0)
[05:19:44.184] Timer tick, asking Buildbucket for the build status
[05:19:44.306] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:44.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:52:0) after 1m0s
[05:20:44.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:52:0)
[05:20:44.389] Timer tick, asking Buildbucket for the build status
[05:20:44.577] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:44.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:53:0) after 1m0s
[05:21:44.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:53:0)
[05:21:44.648] Timer tick, asking Buildbucket for the build status
[05:21:44.784] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:44.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:54:0) after 1m0s
[05:22:44.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:54:0)
[05:22:44.774] Timer tick, asking Buildbucket for the build status
[05:22:44.859] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:44.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:55:0) after 1m0s
[05:23:45.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:55:0)
[05:23:45.057] Timer tick, asking Buildbucket for the build status
[05:23:45.612] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:45.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:56:0) after 1m0s
[05:24:45.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:56:0)
[05:24:45.768] Timer tick, asking Buildbucket for the build status
[05:24:45.948] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:45.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:57:0) after 1m0s
[05:25:45.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:57:0)
[05:25:45.983] Timer tick, asking Buildbucket for the build status
[05:25:46.258] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:46.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:58:0) after 1m0s
[05:26:46.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:58:0)
[05:26:46.434] Timer tick, asking Buildbucket for the build status
[05:26:46.999] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:46.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:59:0) after 1m0s
[05:27:47.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:59:0)
[05:27:47.034] Timer tick, asking Buildbucket for the build status
[05:27:47.864] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:47.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:60:0) after 1m0s
[05:28:47.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:60:0)
[05:28:47.894] Timer tick, asking Buildbucket for the build status
[05:28:48.788] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:48.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:61:0) after 1m0s
[05:29:48.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:61:0)
[05:29:48.990] Timer tick, asking Buildbucket for the build status
[05:29:49.299] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:49.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:62:0) after 1m0s
[05:30:49.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:62:0)
[05:30:49.341] Timer tick, asking Buildbucket for the build status
[05:30:49.886] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:49.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:63:0) after 1m0s
[05:31:49.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:63:0)
[05:31:49.959] Timer tick, asking Buildbucket for the build status
[05:31:50.033] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:50.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:64:0) after 1m0s
[05:32:50.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:64:0)
[05:32:50.044] Timer tick, asking Buildbucket for the build status
[05:32:50.155] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:50.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:65:0) after 1m0s
[05:33:50.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:65:0)
[05:33:50.258] Timer tick, asking Buildbucket for the build status
[05:33:50.390] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:50.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:66:0) after 1m0s
[05:34:50.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:66:0)
[05:34:50.508] Timer tick, asking Buildbucket for the build status
[05:34:50.580] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:50.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:67:0) after 1m0s
[05:35:50.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:67:0)
[05:35:50.610] Timer tick, asking Buildbucket for the build status
[05:35:50.856] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:50.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:68:0) after 1m0s
[05:36:50.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:68:0)
[05:36:50.891] Timer tick, asking Buildbucket for the build status
[05:36:52.785] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:52.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:69:0) after 1m0s
[05:37:52.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:69:0)
[05:37:52.983] Timer tick, asking Buildbucket for the build status
[05:37:53.052] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:53.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:70:0) after 1m0s
[05:38:53.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:70:0)
[05:38:53.266] Timer tick, asking Buildbucket for the build status
[05:38:53.403] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:53.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:71:0) after 1m0s
[05:39:53.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:71:0)
[05:39:53.427] Timer tick, asking Buildbucket for the build status
[05:39:53.625] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:53.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:72:0) after 1m0s
[05:40:53.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:72:0)
[05:40:53.667] Timer tick, asking Buildbucket for the build status
[05:40:53.788] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:53.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:73:0) after 1m0s
[05:41:53.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:73:0)
[05:41:53.984] Timer tick, asking Buildbucket for the build status
[05:41:54.381] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:54.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:74:0) after 1m0s
[05:42:54.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:74:0)
[05:42:54.409] Timer tick, asking Buildbucket for the build status
[05:42:54.591] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:54.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:75:0) after 1m0s
[05:43:54.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:75:0)
[05:43:54.711] Timer tick, asking Buildbucket for the build status
[05:43:54.791] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:54.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:76:0) after 1m0s
[05:44:54.844] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:76:0)
[05:44:54.844] Timer tick, asking Buildbucket for the build status
[05:44:55.216] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:55.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:77:0) after 1m0s
[05:45:55.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:77:0)
[05:45:55.282] Timer tick, asking Buildbucket for the build status
[05:45:55.415] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:55.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:78:0) after 1m0s
[05:46:55.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:78:0)
[05:46:55.580] Timer tick, asking Buildbucket for the build status
[05:46:56.427] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:56.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:79:0) after 1m0s
[05:47:56.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:79:0)
[05:47:56.496] Timer tick, asking Buildbucket for the build status
[05:47:56.786] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:56.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:80:0) after 1m0s
[05:48:56.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:80:0)
[05:48:56.816] Timer tick, asking Buildbucket for the build status
[05:48:56.896] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:56.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:81:0) after 1m0s
[05:49:56.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:81:0)
[05:49:56.971] Timer tick, asking Buildbucket for the build status
[05:49:57.319] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:57.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:82:0) after 1m0s
[05:50:57.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:82:0)
[05:50:57.329] Timer tick, asking Buildbucket for the build status
[05:50:57.451] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:57.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:83:0) after 1m0s
[05:51:57.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:83:0)
[05:51:57.475] Timer tick, asking Buildbucket for the build status
[05:51:57.552] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:57.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:84:0) after 1m0s
[05:52:57.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:84:0)
[05:52:57.574] Timer tick, asking Buildbucket for the build status
[05:52:58.393] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:58.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:85:0) after 1m0s
[05:53:58.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:85:0)
[05:53:58.454] Timer tick, asking Buildbucket for the build status
[05:53:58.649] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:58.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:86:0) after 1m0s
[05:54:58.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:86:0)
[05:54:58.708] Timer tick, asking Buildbucket for the build status
[05:54:58.828] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:58.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:87:0) after 1m0s
[05:55:58.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:87:0)
[05:55:58.884] Timer tick, asking Buildbucket for the build status
[05:55:59.006] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:59.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:88:0) after 1m0s
[05:56:59.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:88:0)
[05:56:59.018] Timer tick, asking Buildbucket for the build status
[05:56:59.198] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:59.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:89:0) after 1m0s
[05:57:59.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:89:0)
[05:57:59.233] Timer tick, asking Buildbucket for the build status
[05:57:59.335] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:59.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:90:0) after 1m0s
[05:58:59.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:90:0)
[05:58:59.366] Timer tick, asking Buildbucket for the build status
[05:59:00.290] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:00.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:91:0) after 1m0s
[06:00:00.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:91:0)
[06:00:00.357] Timer tick, asking Buildbucket for the build status
[06:00:00.424] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:00.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:92:0) after 1m0s
[06:01:01.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:92:0)
[06:01:01.608] Timer tick, asking Buildbucket for the build status
[06:01:01.742] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:01.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:93:0) after 1m0s
[06:02:02.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:93:0)
[06:02:02.442] Timer tick, asking Buildbucket for the build status
[06:02:02.525] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:02.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:94:0) after 1m0s
[06:03:02.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:94:0)
[06:03:02.721] Timer tick, asking Buildbucket for the build status
[06:03:02.927] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:02.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:95:0) after 1m0s
[06:04:02.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:95:0)
[06:04:02.964] Timer tick, asking Buildbucket for the build status
[06:04:03.041] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:03.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:96:0) after 1m0s
[06:05:03.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:96:0)
[06:05:03.563] Timer tick, asking Buildbucket for the build status
[06:05:03.632] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:03.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:97:0) after 1m0s
[06:06:03.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:97:0)
[06:06:03.662] Timer tick, asking Buildbucket for the build status
[06:06:03.830] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:03.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:98:0) after 1m0s
[06:07:03.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:98:0)
[06:07:03.900] Timer tick, asking Buildbucket for the build status
[06:07:04.005] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:04.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:99:0) after 1m0s
[06:08:04.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:99:0)
[06:08:04.142] Timer tick, asking Buildbucket for the build status
[06:08:04.235] Build 8865859386891147952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:04.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031289449016423360:100:0) after 1m0s
[06:08:42.001] Received PubSub notification, asking Buildbucket for the build status
[06:08:42.084] Build 8865859386891147952: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[06:08:42.085] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603260521089635",
"created_by": "project:chromium",
"created_ts": "1603254632060848",
"failure_reason": "BUILD_FAILURE",
"id": "8865859386891147952",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4bdce889ea3596b1cf6c336cd8d17405c2822ad3\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**ash_unittests** failed because of:\\n\\n- QuickActionsViewTest.LocatePhoneToggle\"}, \"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\": \"4bdce889ea3596b1cf6c336cd8d17405c2822ad3\", \"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-46-1ou6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 20943, \"got_angle_revision\": \"9d160b0bba68f5cebb8f66c894c84f95b608eb72\", \"got_dawn_revision\": \"e9c99e93e75ec13ecf143478b9defe92230fc83e\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"4bdce889ea3596b1cf6c336cd8d17405c2822ad3\", \"got_revision_cp\": \"refs/heads/master@{#819224}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"85d9d5d4bbc6ef1a8382df21d92bc6dc0bed4057\", \"got_v8_revision\": \"d20e0a345b623a1373a8833f30c5f7f153b902d7\", \"got_v8_revision_cp\": \"refs/heads/8.8.147@{#1}\", \"got_webrtc_revision\": \"7bc3356fbcb9b95ea2c810ae2f3152930d54577b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32449}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4bdce889ea3596b1cf6c336cd8d17405c2822ad3\", \"swarm_hashes_refs/heads/master(at){#819224}_without_patch\": {\"absl_hardening_tests\": \"b373cb300c56f26bd05b8906cd6eea727dfa963b\", \"accessibility_unittests\": \"5853c05488e22ac20657960780d3aac57b3b42ed\", \"app_list_unittests\": \"6b1de795c0f4ac2ea0e9a25112f116bc287f628f\", \"app_shell_unittests\": \"b701ecca0b87cb183f6a17d0f3448c8bd455e579\", \"ash_unittests\": \"5895f763841199eba15331a5327bb81facfbc0ad\", \"aura_unittests\": \"7a690d1652749ce56206c32e4ccfc8c3bbf8e10a\", \"base_unittests\": \"952cdc74e4aeb7ade9ddaf535d06ed88b09d19b7\", \"base_util_unittests\": \"42c36d161ebbd50525306c7a5ffc2216feddfd14\", \"blink_common_unittests\": \"f339365f1f93d73afb6e6a3f761beeef7e0c2201\", \"blink_fuzzer_unittests\": \"4b1115bbd7dcfd1ad92dd7b79116c6b56c55463a\", \"blink_heap_unittests\": \"edc55ecb7be2ba9628e7ef861ab09cba966f4991\", \"blink_platform_unittests\": \"5eb21bc473896500b8dc09e8aecb1797c788daa5\", \"blink_unittests\": \"e209e42bbb5b0939d05eee451021435ac3afb894\", \"boringssl_crypto_tests\": \"757706f62ec3b750098728776517d0b558ab1dc8\", \"boringssl_ssl_tests\": \"a9ff15f151eaccc3615f069f835857452e5ea1a7\", \"browser_tests\": \"afba9aa839f00724054db762c975510a69b5364c\", \"capture_unittests\": \"ca0b450da52793e40d91c75e3219309e7c6c3601\", \"cast_unittests\": \"469a72fa223be7c1568a6407bab47680ab851b16\", \"cc_unittests\": \"9d7f760c20d723df252e2af9599bb0adf852e135\", \"chrome_app_unittests\": \"0d490db15537a42f9a0c64d26eeaeedad79623c0\", \"chromedriver_unittests\": \"82d98eaa7a2e425f90fba8a9a98ee8cfa4074485\", \"chromeos_components_unittests\": \"1bf007338c855c7dee5c4eea2caac53203fc37a6\", \"chromeos_unittests\": \"ff1810df4ed9656e7f6fb7e392bb5c7a2e29ed48\", \"components_browsertests\": \"6f86d15af9343728006db26a2b25f7c2b4ff022b\", \"components_unittests\": \"6220554884cd4cd2a86c84911f6fa48409713eac\", \"compositor_unittests\": \"588e9b0a3908de4529bdd451e763bccb5be08630\", \"content_browsertests\": \"68db927705d304b9eee8048f59622b17f9ea0d84\", \"content_unittests\": \"7b04e4b9552604b242e0542eb44f79a5f5db627d\", \"crypto_unittests\": \"d0eedb0710630486ac3808d01c243bc8283c52a7\", \"dbus_unittests\": \"90641ef9eb1940939b4e8dac6d0924a6f1a7c2e8\", \"device_unittests\": \"02900a3ff93f064b44741824f51cbc96be67080f\", \"display_unittests\": \"0950a54abef8425e12e42a7a98ed3a76be6d834c\", \"events_unittests\": \"fa17ddededa50fef2116f29139424dd22ffcd9cd\", \"exo_unittests\": \"2e3fb1ed8ac089f51f37f4c10e1a42741a84186f\", \"extensions_browsertests\": \"461781f43c934132b56b4927215e15f1c592ee3a\", \"extensions_unittests\": \"9cd763ce256a0329224772d08787e3306d3dd2cc\", \"filesystem_service_unittests\": \"cb96bcdf016acd85ee4fbaecfc1dd75cf2e91402\", \"gcm_unit_tests\": \"51abe6e351966d1fdeb80b62852726227894c914\", \"gfx_unittests\": \"62f45c4a029f7d9d4a8e3ff78b831b10c1903dd1\", \"gin_unittests\": \"598f2f1a1596b42aae1abaca543f6ff52363316e\", \"gl_unittests_ozone\": \"12a48abe7af96a0904be440eaa3d0a40c1db8684\", \"google_apis_unittests\": \"61e12d51008b307b7073dbcead8c94f35afd077a\", \"gpu_unittests\": \"90694f899bdd96251b300b3570875b55c8509543\", \"gwp_asan_unittests\": \"f5aaea60552dfab13bc172afc4c2a5a66973f9e9\", \"interactive_ui_tests\": \"a3f8c25235fe936b963d9e37abc4c51476af29e7\", \"ipc_tests\": \"58177733bd4ee82564168fe0c7084121ef4eba74\", \"jingle_unittests\": \"f3f3da885cfa0e1fa285a6d3ee080c6c5a5b2d4b\", \"keyboard_unittests\": \"478821ec9672c0b11987bf72b795f3f4eaae77ae\", \"latency_unittests\": \"96fc44dd7bd95f38c35b8030cd9c08466f251b5f\", \"libjingle_xmpp_unittests\": \"798e80801c01f34e849ab30ae37105cb9ec5a305\", \"media_blink_unittests\": \"45f26b293f124ef528bfa7e6426441fe13600cf8\", \"media_unittests\": \"32f14fed1ad80983eed321f8dd7b1970afe0cbd6\", \"message_center_unittests\": \"76c052f43b86721c2b8614e6d5e80f54a0a5a24c\", \"midi_unittests\": \"f28e16a5e987549f6b1725a9b9735d1972568f3d\", \"mojo_core_unittests\": \"fb1d251ceeb4fce778cc95025a5296319e5e9a5c\", \"mojo_unittests\": \"7ec480219a5dc4552a72e285aeb5acd413b8d8db\", \"nacl_helper_nonsfi_unittests\": \"27847aa0b664ba835c1140bdad86766bbbaddd3c\", \"nacl_loader_unittests\": \"27d74bfe14f7dce0b564841c50b4748f2bd118aa\", \"native_theme_unittests\": \"f86ec573a7accbcee54038b813ff766ebce0020e\", \"net_unittests\": \"b8e48403f4d3ba1da1d35a7d96192a507a1800b9\", \"ozone_gl_unittests\": \"d495fb3a320d88faf1969c679d2adfb512fc0db5\", \"ozone_unittests\": \"0702509b961d8aba267f8029475a8045b9664b3f\", \"ozone_x11_unittests\": \"515a85252720ddf0ba116b8cbdfb8a0afd5417cb\", \"pdf_unittests\": \"c5cc821b43d1f1dafb562a81bc8282c5c71d0b45\", \"perfetto_unittests\": \"aaf00970e5576c944047f287430b22dce3fe166d\", \"ppapi_unittests\": \"edc4fa057da28ce0235cbfcb417ed39a947d816f\", \"printing_unittests\": \"be862cdac87568cccab9c2907ee3130a77f14a28\", \"remoting_unittests\": \"1d80aedee4784b7ae23fd92826c1791693ae4aee\", \"sandbox_linux_unittests\": \"128c11753f208827d8f03890adb107173927fce7\", \"service_manager_unittests\": \"3ea12a2403d6ee1ce887977b2a1aafabc39d8aad\", \"services_unittests\": \"231ffb17d5efcb5153c91d762f20ba1560e69c19\", \"shell_dialogs_unittests\": \"c6b074f53e9bb721728b54be9bcf49b37b67b44c\", \"skia_unittests\": \"d128e9e1d7b6b931f7368248b0ce02e29c4f0391\", \"snapshot_unittests\": \"f162bca369a861247de542d9cac8fafeb0061457\", \"sql_unittests\": \"ae0fe9bccd1b1ff2914966509a9bb7f5fe943989\", \"standalone_angle_unittests\": \"cd5df3cf8aa021bf4f169610ab87d2dd57fb3ec8\", \"storage_unittests\": \"3bb40dd39d36238384b94dc44a888e13596fc84d\", \"sync_integration_tests\": \"94742555358e792ac38c80e2d51215a2228d34a3\", \"traffic_annotation_auditor_unittests\": \"75475b4d3f8ea373bb3a8dbf0b59eafb662ba739\", \"ui_base_unittests\": \"d2a9af67794a87c7944204c992fc9e7dac72fe54\", \"ui_chromeos_unittests\": \"5302dcc4b7e9ed2d07a504ccae905f767cc5b480\", \"ui_touch_selection_unittests\": \"de48e2297363a67164ee6965e87859b9122f5b06\", \"unit_tests\": \"c5a080ee95b78533e24c91f17733c4da5a14632c\", \"url_unittests\": \"38b9ec7f0d803e49d3c9e35f742218aaeef76f26\", \"usage_time_limit_unittests\": \"7d1a921c36b69c066df3e41e91d15295fdf5da19\", \"views_unittests\": \"61d88f9d8ec7d82ad033e3223ce26c6ba12ef8ca\", \"viz_unittests\": \"fbb58e341d26fa22cf101a988cb6da2ff83b59c8\", \"wm_unittests\": \"122d2006d753a8519b704601612912cebcf699f0\", \"wtf_unittests\": \"3164be687dd5358c7aeaccd5a025d0fd3755714b\", \"zlib_unittests\": \"63fb98aec4e9d89a87617ae014ed83b509d26c42\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_62ff673344f63b1d0862893f2031420df362e89a2b43f8f65e2ede9a934c5b6f_v2\", \"builder_a432d290b72bc0f3cae401fbd647c33c14340f64e89770e9c9c39d6230495526_v2\", \"builder_b5e41ce0b01ce81870a1097ddb1343f2a3924630f4d3bb9f1a0eaa4d6a5abbed_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_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-46-1ou6\"], \"image\": [\"chrome-xenial-20101400-bb93c5ec2c2\"], \"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\": [\"5601-97d7e7d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**ash_unittests** failed because of:\\n\\n- QuickActionsViewTest.LocatePhoneToggle\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603254672838748",
"status": "COMPLETED",
"status_changed_ts": "1603254673297126",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20943",
"builder:linux-chromeos-dbg",
"buildset:commit/git/4bdce889ea3596b1cf6c336cd8d17405c2822ad3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4bdce889ea3596b1cf6c336cd8d17405c2822ad3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031289449016423360",
"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/8865859386891147952/+/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:4f623dcbfd9db410",
"user_agent:luci-scheduler"
],
"updated_ts": "1603260521497615",
"url": "https://ci.chromium.org/b/8865859386891147952",
"utcnow_ts": "1603260522071985"
}
}
[06:08:42.085] Invocation finished in 1h38m11.434104096s with status FAILED