[22:53:39.430] New invocation is queued and will start shortly
[22:53:40.669] Starting the invocation (attempt 1)
[22:53:40.730] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:53:40.730] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:53:40.730] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025150048317808704",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c4cb86a6a8f3fbfd67bdb62887d51871936026d3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9025150048317808704",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/c4cb86a6a8f3fbfd67bdb62887d51871936026d3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4cb86a6a8f3fbfd67bdb62887d51871936026d3",
"gitiles_ref:refs/heads/master"
]
}
[22:53:42.483] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609109620831650",
"id": "8859719986185761376",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4cb86a6a8f3fbfd67bdb62887d51871936026d3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609109622083726",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21941",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c4cb86a6a8f3fbfd67bdb62887d51871936026d3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4cb86a6a8f3fbfd67bdb62887d51871936026d3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025150048317808704",
"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/8859719986185761376/+/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": "1609109622083935",
"url": "https://ci.chromium.org/b/8859719986185761376",
"utcnow_ts": "1609109622469299"
}
}
[22:53:42.483] Task URL: https://ci.chromium.org/b/8859719986185761376
[22:53:42.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:2:0) after 1m0s
[22:54:42.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:2:0)
[22:54:42.503] Timer tick, asking Buildbucket for the build status
[22:54:42.787] Build 8859719986185761376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:42.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:3:0) after 1m0s
[22:55:42.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:3:0)
[22:55:42.853] Timer tick, asking Buildbucket for the build status
[22:55:42.924] Build 8859719986185761376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:42.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:4:0) after 1m0s
[22:56:42.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:4:0)
[22:56:42.963] Timer tick, asking Buildbucket for the build status
[22:56:43.168] Build 8859719986185761376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:43.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:5:0) after 1m0s
[22:57:43.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:5:0)
[22:57:43.237] Timer tick, asking Buildbucket for the build status
[22:57:43.605] Build 8859719986185761376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:43.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:6:0) after 1m0s
[22:58:43.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:6:0)
[22:58:43.694] Timer tick, asking Buildbucket for the build status
[22:58:43.981] Build 8859719986185761376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:43.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:7:0) after 1m0s
[22:59:44.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:7:0)
[22:59:44.052] Timer tick, asking Buildbucket for the build status
[22:59:44.164] Build 8859719986185761376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:44.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:8:0) after 1m0s
[23:00:44.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:8:0)
[23:00:44.186] Timer tick, asking Buildbucket for the build status
[23:00:44.245] Build 8859719986185761376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:44.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:9:0) after 1m0s
[23:01:44.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:9:0)
[23:01:44.346] Timer tick, asking Buildbucket for the build status
[23:01:44.413] Build 8859719986185761376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:44.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:10:0) after 1m0s
[23:02:44.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:10:0)
[23:02:44.433] Timer tick, asking Buildbucket for the build status
[23:02:44.533] Build 8859719986185761376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:44.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:11:0) after 1m0s
[23:03:44.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:11:0)
[23:03:44.552] Timer tick, asking Buildbucket for the build status
[23:03:44.666] Build 8859719986185761376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:44.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:12:0) after 1m0s
[23:04:44.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:12:0)
[23:04:44.723] Timer tick, asking Buildbucket for the build status
[23:04:44.967] Build 8859719986185761376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:44.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:13:0) after 1m0s
[23:05:16.042] Received PubSub notification, asking Buildbucket for the build status
[23:05:16.187] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:44.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:13:0)
[23:05:44.953] Timer tick, asking Buildbucket for the build status
[23:05:45.092] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:45.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:15:0) after 1m0s
[23:06:45.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:15:0)
[23:06:45.131] Timer tick, asking Buildbucket for the build status
[23:06:45.198] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:45.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:16:0) after 1m0s
[23:07:45.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:16:0)
[23:07:45.237] Timer tick, asking Buildbucket for the build status
[23:07:45.283] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:45.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:17:0) after 1m0s
[23:08:45.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:17:0)
[23:08:45.303] Timer tick, asking Buildbucket for the build status
[23:08:45.804] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:45.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:18:0) after 1m0s
[23:09:45.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:18:0)
[23:09:45.881] Timer tick, asking Buildbucket for the build status
[23:09:45.957] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:45.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:19:0) after 1m0s
[23:10:45.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:19:0)
[23:10:45.976] Timer tick, asking Buildbucket for the build status
[23:10:46.032] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:46.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:20:0) after 1m0s
[23:11:46.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:20:0)
[23:11:46.074] Timer tick, asking Buildbucket for the build status
[23:11:46.134] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:46.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:21:0) after 1m0s
[23:12:46.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:21:0)
[23:12:46.301] Timer tick, asking Buildbucket for the build status
[23:12:46.461] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:46.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:22:0) after 1m0s
[23:13:46.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:22:0)
[23:13:46.436] Timer tick, asking Buildbucket for the build status
[23:13:46.555] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:46.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:23:0) after 1m0s
[23:14:46.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:23:0)
[23:14:46.575] Timer tick, asking Buildbucket for the build status
[23:14:46.787] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:46.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:24:0) after 1m0s
[23:15:46.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:24:0)
[23:15:46.809] Timer tick, asking Buildbucket for the build status
[23:15:47.012] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:47.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:25:0) after 1m0s
[23:16:47.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:25:0)
[23:16:47.039] Timer tick, asking Buildbucket for the build status
[23:16:47.106] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:47.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:26:0) after 1m0s
[23:17:47.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:26:0)
[23:17:47.220] Timer tick, asking Buildbucket for the build status
[23:17:47.284] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:47.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:27:0) after 1m0s
[23:18:47.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:27:0)
[23:18:47.310] Timer tick, asking Buildbucket for the build status
[23:18:47.391] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:47.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:28:0) after 1m0s
[23:19:49.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:28:0)
[23:19:49.385] Timer tick, asking Buildbucket for the build status
[23:19:49.464] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:49.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:29:0) after 1m0s
[23:20:49.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:29:0)
[23:20:49.814] Timer tick, asking Buildbucket for the build status
[23:20:49.969] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:49.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:30:0) after 1m0s
[23:21:50.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:30:0)
[23:21:50.027] Timer tick, asking Buildbucket for the build status
[23:21:50.073] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:50.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:31:0) after 1m0s
[23:22:50.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:31:0)
[23:22:50.256] Timer tick, asking Buildbucket for the build status
[23:22:50.311] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:50.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:32:0) after 1m0s
[23:23:50.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:32:0)
[23:23:50.777] Timer tick, asking Buildbucket for the build status
[23:23:50.901] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:50.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:33:0) after 1m0s
[23:24:51.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:33:0)
[23:24:51.234] Timer tick, asking Buildbucket for the build status
[23:24:51.308] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:51.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:34:0) after 1m0s
[23:25:51.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:34:0)
[23:25:51.450] Timer tick, asking Buildbucket for the build status
[23:25:51.518] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:51.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:35:0) after 1m0s
[23:26:51.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:35:0)
[23:26:51.679] Timer tick, asking Buildbucket for the build status
[23:26:51.737] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:51.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:36:0) after 1m0s
[23:27:51.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:36:0)
[23:27:51.989] Timer tick, asking Buildbucket for the build status
[23:27:52.053] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:52.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:37:0) after 1m0s
[23:28:52.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:37:0)
[23:28:52.225] Timer tick, asking Buildbucket for the build status
[23:28:52.325] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:52.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:38:0) after 1m0s
[23:29:52.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:38:0)
[23:29:52.386] Timer tick, asking Buildbucket for the build status
[23:29:52.499] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:52.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:39:0) after 1m0s
[23:30:52.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:39:0)
[23:30:52.585] Timer tick, asking Buildbucket for the build status
[23:30:52.641] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:52.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:40:0) after 1m0s
[23:31:52.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:40:0)
[23:31:52.706] Timer tick, asking Buildbucket for the build status
[23:31:52.762] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:52.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:41:0) after 1m0s
[23:32:52.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:41:0)
[23:32:52.882] Timer tick, asking Buildbucket for the build status
[23:32:52.984] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:52.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:42:0) after 1m0s
[23:33:53.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:42:0)
[23:33:53.135] Timer tick, asking Buildbucket for the build status
[23:33:53.299] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:53.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:43:0) after 1m0s
[23:34:53.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:43:0)
[23:34:53.565] Timer tick, asking Buildbucket for the build status
[23:34:53.667] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:53.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:44:0) after 1m0s
[23:35:53.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:44:0)
[23:35:53.883] Timer tick, asking Buildbucket for the build status
[23:35:53.934] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:53.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:45:0) after 1m0s
[23:36:54.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:45:0)
[23:36:54.148] Timer tick, asking Buildbucket for the build status
[23:36:54.332] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:54.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:46:0) after 1m0s
[23:37:54.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:46:0)
[23:37:54.363] Timer tick, asking Buildbucket for the build status
[23:37:54.416] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:54.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:47:0) after 1m0s
[23:38:54.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:47:0)
[23:38:54.462] Timer tick, asking Buildbucket for the build status
[23:38:54.805] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:54.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:48:0) after 1m0s
[23:39:54.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:48:0)
[23:39:54.884] Timer tick, asking Buildbucket for the build status
[23:39:55.184] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:55.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:49:0) after 1m0s
[23:40:55.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:49:0)
[23:40:55.398] Timer tick, asking Buildbucket for the build status
[23:40:55.457] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:55.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:50:0) after 1m0s
[23:41:55.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:50:0)
[23:41:55.572] Timer tick, asking Buildbucket for the build status
[23:41:55.906] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:55.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:51:0) after 1m0s
[23:42:55.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:51:0)
[23:42:55.921] Timer tick, asking Buildbucket for the build status
[23:42:56.168] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:56.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:52:0) after 1m0s
[23:43:56.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:52:0)
[23:43:56.227] Timer tick, asking Buildbucket for the build status
[23:43:56.321] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:56.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:53:0) after 1m0s
[23:44:56.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:53:0)
[23:44:56.351] Timer tick, asking Buildbucket for the build status
[23:44:56.511] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:56.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:54:0) after 1m0s
[23:45:56.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:54:0)
[23:45:56.565] Timer tick, asking Buildbucket for the build status
[23:45:56.644] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:56.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:55:0) after 1m0s
[23:46:56.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:55:0)
[23:46:56.660] Timer tick, asking Buildbucket for the build status
[23:46:56.718] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:56.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:56:0) after 1m0s
[23:47:56.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:56:0)
[23:47:56.791] Timer tick, asking Buildbucket for the build status
[23:47:56.863] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:56.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:57:0) after 1m0s
[23:48:56.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:57:0)
[23:48:56.910] Timer tick, asking Buildbucket for the build status
[23:48:57.010] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:57.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:58:0) after 1m0s
[23:49:57.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:58:0)
[23:49:57.028] Timer tick, asking Buildbucket for the build status
[23:49:57.200] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:57.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:59:0) after 1m0s
[23:50:57.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:59:0)
[23:50:57.227] Timer tick, asking Buildbucket for the build status
[23:50:57.311] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:57.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:60:0) after 1m0s
[23:51:57.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:60:0)
[23:51:57.376] Timer tick, asking Buildbucket for the build status
[23:51:57.611] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:57.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:61:0) after 1m0s
[23:52:57.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:61:0)
[23:52:57.685] Timer tick, asking Buildbucket for the build status
[23:52:57.919] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:57.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:62:0) after 1m0s
[23:53:57.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:62:0)
[23:53:57.992] Timer tick, asking Buildbucket for the build status
[23:53:58.082] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:58.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:63:0) after 1m0s
[23:54:58.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:63:0)
[23:54:58.119] Timer tick, asking Buildbucket for the build status
[23:54:58.173] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:58.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:64:0) after 1m0s
[23:55:58.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:64:0)
[23:55:58.199] Timer tick, asking Buildbucket for the build status
[23:55:58.285] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:58.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:65:0) after 1m0s
[23:56:58.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:65:0)
[23:56:58.313] Timer tick, asking Buildbucket for the build status
[23:56:58.437] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:58.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:66:0) after 1m0s
[23:57:58.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:66:0)
[23:57:58.466] Timer tick, asking Buildbucket for the build status
[23:57:58.643] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:58.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:67:0) after 1m0s
[23:58:58.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:67:0)
[23:58:58.664] Timer tick, asking Buildbucket for the build status
[23:58:59.283] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:59.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:68:0) after 1m0s
[23:59:59.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:68:0)
[23:59:59.308] Timer tick, asking Buildbucket for the build status
[23:59:59.408] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:59.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:69:0) after 1m0s
[00:00:59.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:69:0)
[00:00:59.428] Timer tick, asking Buildbucket for the build status
[00:00:59.708] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:59.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:70:0) after 1m0s
[00:01:59.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:70:0)
[00:01:59.730] Timer tick, asking Buildbucket for the build status
[00:01:59.876] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:59.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:71:0) after 1m0s
[00:02:59.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:71:0)
[00:02:59.946] Timer tick, asking Buildbucket for the build status
[00:03:00.288] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:00.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:72:0) after 1m0s
[00:04:00.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:72:0)
[00:04:00.886] Timer tick, asking Buildbucket for the build status
[00:04:01.295] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:01.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:73:0) after 1m0s
[00:05:01.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:73:0)
[00:05:01.818] Timer tick, asking Buildbucket for the build status
[00:05:02.318] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:02.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:74:0) after 1m0s
[00:06:02.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:74:0)
[00:06:02.550] Timer tick, asking Buildbucket for the build status
[00:06:02.616] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:02.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:75:0) after 1m0s
[00:07:03.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:75:0)
[00:07:03.156] Timer tick, asking Buildbucket for the build status
[00:07:03.260] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:03.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:76:0) after 1m0s
[00:08:03.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:76:0)
[00:08:03.681] Timer tick, asking Buildbucket for the build status
[00:08:03.940] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:03.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:77:0) after 1m0s
[00:09:04.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:77:0)
[00:09:04.334] Timer tick, asking Buildbucket for the build status
[00:09:04.697] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:04.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:78:0) after 1m0s
[00:10:04.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:78:0)
[00:10:04.980] Timer tick, asking Buildbucket for the build status
[00:10:05.065] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:05.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:79:0) after 1m0s
[00:11:05.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:79:0)
[00:11:05.415] Timer tick, asking Buildbucket for the build status
[00:11:05.470] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:05.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:80:0) after 1m0s
[00:12:05.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:80:0)
[00:12:05.985] Timer tick, asking Buildbucket for the build status
[00:12:06.110] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:06.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:81:0) after 1m0s
[00:13:06.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:81:0)
[00:13:06.098] Timer tick, asking Buildbucket for the build status
[00:13:06.154] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:06.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:82:0) after 1m0s
[00:14:06.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:82:0)
[00:14:06.297] Timer tick, asking Buildbucket for the build status
[00:14:06.522] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:06.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:83:0) after 1m0s
[00:15:06.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:83:0)
[00:15:06.623] Timer tick, asking Buildbucket for the build status
[00:15:06.794] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:06.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:84:0) after 1m0s
[00:16:06.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:84:0)
[00:16:06.911] Timer tick, asking Buildbucket for the build status
[00:16:07.494] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:07.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:85:0) after 1m0s
[00:17:07.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:85:0)
[00:17:07.537] Timer tick, asking Buildbucket for the build status
[00:17:07.813] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:07.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:86:0) after 1m0s
[00:18:07.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:86:0)
[00:18:07.880] Timer tick, asking Buildbucket for the build status
[00:18:07.989] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:07.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:87:0) after 1m0s
[00:19:08.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:87:0)
[00:19:08.011] Timer tick, asking Buildbucket for the build status
[00:19:08.123] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:08.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:88:0) after 1m0s
[00:20:08.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:88:0)
[00:20:08.164] Timer tick, asking Buildbucket for the build status
[00:20:08.417] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:08.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:89:0) after 1m0s
[00:21:08.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:89:0)
[00:21:08.491] Timer tick, asking Buildbucket for the build status
[00:21:08.586] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:08.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:90:0) after 1m0s
[00:22:08.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:90:0)
[00:22:08.671] Timer tick, asking Buildbucket for the build status
[00:22:08.754] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:08.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:91:0) after 1m0s
[00:23:08.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:91:0)
[00:23:08.821] Timer tick, asking Buildbucket for the build status
[00:23:08.904] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:08.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:92:0) after 1m0s
[00:24:08.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:92:0)
[00:24:08.911] Timer tick, asking Buildbucket for the build status
[00:24:09.106] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:09.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:93:0) after 1m0s
[00:25:09.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:93:0)
[00:25:09.136] Timer tick, asking Buildbucket for the build status
[00:25:09.202] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:09.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:94:0) after 1m0s
[00:26:09.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:94:0)
[00:26:09.225] Timer tick, asking Buildbucket for the build status
[00:26:09.377] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:09.377] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:95:0) after 1m0s
[00:27:09.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:95:0)
[00:27:09.519] Timer tick, asking Buildbucket for the build status
[00:27:09.576] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:09.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:96:0) after 1m0s
[00:28:09.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:96:0)
[00:28:09.599] Timer tick, asking Buildbucket for the build status
[00:28:09.660] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:09.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:97:0) after 1m0s
[00:29:09.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:97:0)
[00:29:09.703] Timer tick, asking Buildbucket for the build status
[00:29:10.288] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:10.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:98:0) after 1m0s
[00:30:10.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:98:0)
[00:30:10.316] Timer tick, asking Buildbucket for the build status
[00:30:10.380] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:10.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:99:0) after 1m0s
[00:31:10.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:99:0)
[00:31:10.407] Timer tick, asking Buildbucket for the build status
[00:31:10.474] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:10.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:100:0) after 1m0s
[00:32:10.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:100:0)
[00:32:10.496] Timer tick, asking Buildbucket for the build status
[00:32:10.633] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:10.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:101:0) after 1m0s
[00:33:10.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:101:0)
[00:33:10.655] Timer tick, asking Buildbucket for the build status
[00:33:10.719] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:10.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:102:0) after 1m0s
[00:34:10.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:102:0)
[00:34:10.797] Timer tick, asking Buildbucket for the build status
[00:34:11.097] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:11.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:103:0) after 1m0s
[00:35:11.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:103:0)
[00:35:11.122] Timer tick, asking Buildbucket for the build status
[00:35:11.503] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:11.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:104:0) after 1m0s
[00:36:11.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:104:0)
[00:36:11.529] Timer tick, asking Buildbucket for the build status
[00:36:11.689] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:11.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:105:0) after 1m0s
[00:37:11.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:105:0)
[00:37:11.711] Timer tick, asking Buildbucket for the build status
[00:37:11.811] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:11.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:106:0) after 1m0s
[00:38:11.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:106:0)
[00:38:11.843] Timer tick, asking Buildbucket for the build status
[00:38:12.091] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:12.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:107:0) after 1m0s
[00:39:12.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:107:0)
[00:39:12.118] Timer tick, asking Buildbucket for the build status
[00:39:12.275] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:12.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:108:0) after 1m0s
[00:40:12.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:108:0)
[00:40:12.344] Timer tick, asking Buildbucket for the build status
[00:40:12.425] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:12.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:109:0) after 1m0s
[00:41:12.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:109:0)
[00:41:12.474] Timer tick, asking Buildbucket for the build status
[00:41:12.549] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:12.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:110:0) after 1m0s
[00:42:12.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:110:0)
[00:42:12.686] Timer tick, asking Buildbucket for the build status
[00:42:12.803] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:12.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:111:0) after 1m0s
[00:43:13.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:111:0)
[00:43:13.018] Timer tick, asking Buildbucket for the build status
[00:43:13.080] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:13.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:112:0) after 1m0s
[00:44:13.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:112:0)
[00:44:13.224] Timer tick, asking Buildbucket for the build status
[00:44:13.363] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:13.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:113:0) after 1m0s
[00:45:13.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:113:0)
[00:45:13.381] Timer tick, asking Buildbucket for the build status
[00:45:13.492] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:13.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:114:0) after 1m0s
[00:46:13.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:114:0)
[00:46:13.530] Timer tick, asking Buildbucket for the build status
[00:46:13.588] Build 8859719986185761376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:13.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9025150048317808704:115:0) after 1m0s
[00:46:30.574] Received PubSub notification, asking Buildbucket for the build status
[00:46:30.711] Build 8859719986185761376: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[00:46:30.711] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609116389611561",
"created_by": "project:chromium",
"created_ts": "1609109620831650",
"failure_reason": "BUILD_FAILURE",
"id": "8859719986185761376",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4cb86a6a8f3fbfd67bdb62887d51871936026d3\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- All/SystemWebAppManagerUpgradeBrowserTest.Upgrade/_Default\\n\\n- All/SystemWebAppManagerUpgradeBrowserTest.Upgrade/_WebAppInfoInstall\"}, \"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\": \"c4cb86a6a8f3fbfd67bdb62887d51871936026d3\", \"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-east1-d-8-96-vnll\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21941, \"got_angle_revision\": \"5e606e5bfce2b23c139c5289cbf1299844fa4b43\", \"got_dawn_revision\": \"c8d5277e86ee8c51b1dd7892b41e83eb26ac2ede\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"c4cb86a6a8f3fbfd67bdb62887d51871936026d3\", \"got_revision_cp\": \"refs/heads/master@{#839404}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"4d7ae9713defe93b6f3de031454727a30c70a734\", \"got_v8_revision_cp\": \"refs/heads/8.9.192@{#1}\", \"got_webrtc_revision\": \"b90546580ec3e8236225f39f9e5e5e7b7128c24b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32881}\", \"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\": \"c4cb86a6a8f3fbfd67bdb62887d51871936026d3\", \"swarm_hashes_refs/heads/master(at){#839404}_without_patch\": {\"absl_hardening_tests\": \"cd404f8425335c648e2e50d5a2c9d0ef6e9840d7\", \"accessibility_unittests\": \"eb6b7ea06da9414c06960482739f2b1df9717a84\", \"angle_unittests\": \"458398872ab8f4585f7bbf127c4183c7436e36d8\", \"app_list_unittests\": \"16ba7acd99c4b5ae6c2a8019300540a7a1990f6a\", \"app_shell_unittests\": \"947e443d2de6473a4b427fac03b9a4ae570e028f\", \"ash_unittests\": \"d3c341fcd43c447dd03a2e088109b9ea63398e63\", \"aura_unittests\": \"eea440df0520d673bd0969755ebc747d1d0fcdc4\", \"base_unittests\": \"e42f49751e9fc25866642250ba84767bac15f2dc\", \"base_util_unittests\": \"6f322ea279fd2ef7918735cbb3f6edb6bace70dd\", \"blink_common_unittests\": \"73d7ff6c0a36125c08695b6e4cc86679bdd380d8\", \"blink_fuzzer_unittests\": \"bdf27162749bf28069174733b2d338245294a93d\", \"blink_heap_unittests\": \"2bf04f8ac3f4c0fc430ef230aa9e6c9bc58f78f4\", \"blink_platform_unittests\": \"16393d67b37bfb43e5cc2a5ea53d8e8d5d6f243d\", \"blink_unittests\": \"defb6586a35d428196a3dfb2f0cc985651ecb07b\", \"boringssl_crypto_tests\": \"7f08e2b30c0f564298968bbb3af42984298d462a\", \"boringssl_ssl_tests\": \"97add7212f7414f9aa63e65bfc360066ea39df99\", \"browser_tests\": \"4302b0c0182015625398c75eccf99f94bc2ecebb\", \"capture_unittests\": \"02f51e7e0e0fbcd5530229c84c2d726608d262e1\", \"cast_unittests\": \"5a5e09500ad0896f28f25daf4d600fca334e6e83\", \"cc_unittests\": \"2c7c56a6e462e29f1d4f5fd32d3d2e7592f25f5b\", \"chrome_app_unittests\": \"731d9bb9307ebf176c077b6de822ea907c766cbe\", \"chromedriver_unittests\": \"d7e6dbe7ae94c9bf48a69343d74b94543153ce5d\", \"chromeos_components_unittests\": \"679d29309f657a6c107b2178d1a6ccd514197c14\", \"chromeos_unittests\": \"bd9d0f9ca626e0ebfd49d1fe5d1b0b3633cfc18e\", \"components_browsertests\": \"add56b18f16993fae8f0d9b3638a21e8e53d47d2\", \"components_unittests\": \"dd1efc5c246f45cf84283f8c8685e1156ae92cc7\", \"compositor_unittests\": \"858b05e7db425523f6aa66a6e68ae3eef5a94d22\", \"content_browsertests\": \"27a8890b437434a6edd0d599a248a297e63243ae\", \"content_unittests\": \"a52f357204e4f74e8612d462b02204ca2170353b\", \"crashpad_tests\": \"f28dbdfed6fe66be37d78e9ca503ebda8290fc19\", \"crypto_unittests\": \"6e0a7d9217f0135a501067cd12a53ab6a2aadb64\", \"dbus_unittests\": \"8e9f1a2ab870c84abcee8f924edf306a94c6977a\", \"device_unittests\": \"824d9241c53123c65df28b35a8e6094837640127\", \"display_unittests\": \"72c0171053e2c863b7b397481fbb63fb03451c46\", \"events_unittests\": \"f96df053a104b1c219ca284a58cfce13c7fc137c\", \"exo_unittests\": \"52f92e5e505b9f23ac00d3b896e2e622292535a2\", \"extensions_browsertests\": \"d1e332b7ec5a3423e5d18fb86dd927677e623935\", \"extensions_unittests\": \"e67c83fc3c01da257910a227395254f233b77088\", \"filesystem_service_unittests\": \"d2526de8e945dfb783cfbd67b4031f31566ff0c1\", \"gcm_unit_tests\": \"80e8068766aa76e4289dda9a00050ba4427b9b4b\", \"gfx_unittests\": \"053ed4754e1d31f5dc3db006c4bc6be1f652058a\", \"gin_unittests\": \"4521e9fa936c1e60d735eb56274b95f674d637a4\", \"gl_unittests_ozone\": \"883ee0334954faa2814ac5d8bd5f6d1b85f1302c\", \"google_apis_unittests\": \"7ff39ca9d5a2b40a013d41c9dec20113067a41b1\", \"gpu_unittests\": \"c2bacd24a27edb2c0266b4dcb428e522f354933a\", \"gwp_asan_unittests\": \"6897fe3802fa6eb39e0584dceaf4ddc135a2c2e6\", \"interactive_ui_tests\": \"01c108ebd69b413837312a784002c44930083213\", \"ipc_tests\": \"a4e859b3a36aaa2ad2f24250fb6a8e87381b45a9\", \"jingle_unittests\": \"c2bf8bcaef7cddd16e6fccde91181b252e0ab3bc\", \"keyboard_unittests\": \"e3be90293d3db18b71c103453192140bb9ed2e3d\", \"latency_unittests\": \"85e161a4194a5823b385da744969c346581f81d4\", \"libjingle_xmpp_unittests\": \"7643aa7acaf882e7093fb4bfee43244201eadb4c\", \"liburlpattern_unittests\": \"80c08b51788b9ddae4aac08adce0f2041416f187\", \"media_blink_unittests\": \"7d94a3f57f6b414e1df1d2aaa88ea302391c2652\", \"media_unittests\": \"cef1317735c9898b0692651507a2e5d7efe8549f\", \"message_center_unittests\": \"bef14e3d919f810ba9c300a2070b527d006dbc94\", \"midi_unittests\": \"c8b00e9204bf23a6e26091fb5d0ed2d2db922fdc\", \"mojo_core_unittests\": \"93e93cde641fad93ae662d2e195dadecad3cccb7\", \"mojo_unittests\": \"4f0130c5c9fc6412df3093641c5d8941f30dd15d\", \"nacl_helper_nonsfi_unittests\": \"f245f0b36df47aaeae39224aa00047c2ec81bbd3\", \"nacl_loader_unittests\": \"d4c41c2c1697940053e0de24f0390fb07b2b5cd4\", \"native_theme_unittests\": \"96dadfec7f471400334eb4aadcc7c4af3b1edd0b\", \"net_unittests\": \"fcd0258c62c9991f25e798c9a5e0ee1124085a20\", \"ozone_gl_unittests\": \"8c18b3643a95d66824b4e53b0a386ba895f9c63d\", \"ozone_unittests\": \"bc58a5b75236996c0aa18643a902301bb66a8b02\", \"ozone_x11_unittests\": \"3de463822c4723360ad6f6242c3943b0585fd98a\", \"pdf_unittests\": \"abecfc460607bd94835daaa978ea6e9c169478d7\", \"perfetto_unittests\": \"bff4db0800dba4b214c9de35474a8a99b97a6969\", \"ppapi_unittests\": \"97d5b7efc6dd79931842dfec2348890a7a58fc34\", \"printing_unittests\": \"7c3e0d96f39a2bb924355b86ac70770f11c2eacc\", \"remoting_unittests\": \"6fc60c7179abc6fabdec4cacda096f9e15c536ae\", \"sandbox_linux_unittests\": \"b2e71ae9dbaffb90dfffe56bd3272403462f707b\", \"service_manager_unittests\": \"731528bd119bff7b346e0ec8a4fdee02602f6034\", \"services_unittests\": \"479cb0c762020f9d14ed36afaf299fa5c57f22e6\", \"shell_dialogs_unittests\": \"168f4106b7e934889e2bb344a5da5d2670b949ed\", \"shell_encryption_unittests\": \"4354b9c4c07192bd0ff3d63bc1e7254c24b47bfd\", \"skia_unittests\": \"0e044281d6b6b355ee7796498b222435c8a3b132\", \"snapshot_unittests\": \"72b72147561295b1f63d5188801ffc57c5cd2fe1\", \"sql_unittests\": \"69ed204a6c984595683a2391f5294aba02799176\", \"storage_unittests\": \"005a9eaf3abd139a5acc7e373b6bd022260a5ce8\", \"sync_integration_tests\": \"b81c7dffd10187b58a04c13b6b66df759f4e3737\", \"traffic_annotation_auditor_unittests\": \"531f99a484e1b2baa8a50e8832f1957bf8a24a59\", \"ui_base_unittests\": \"f38ccfd19887df84c1969c575d93c8889900830c\", \"ui_chromeos_unittests\": \"aa1f95f8dc1288eb2a62314537d9423dda0ba607\", \"ui_touch_selection_unittests\": \"0471e0b4183fe225f09858990fcd4fed3a7fdb0f\", \"unit_tests\": \"63ae2033f2e9f1ca8d4a4440c95ebc1ecc74e429\", \"url_unittests\": \"3e5b79dfd5921f6d91055eaa034bb851fa62cdc1\", \"usage_time_limit_unittests\": \"a972bc32197de933b1d13b9f82ce93f8c2b2b775\", \"views_unittests\": \"888081ff4f0b169356c0d64b9c2fa2619c0377a1\", \"viz_unittests\": \"6221a22a908f4ac2c49b09c2c937a88896da7666\", \"wm_unittests\": \"43583fd9f4596dad543a80414d20ec106fe6930b\", \"wtf_unittests\": \"68963eef8873372faaf2c72d0fc1d4c62bafeefe\", \"zlib_unittests\": \"77fae4b3e796306b8d99c33c5a1ca0ce8304b3bc\"}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- All/SystemWebAppManagerUpgradeBrowserTest.Upgrade/_Default\\n\\n- All/SystemWebAppManagerUpgradeBrowserTest.Upgrade/_WebAppInfoInstall\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1609110314679584",
"status": "COMPLETED",
"status_changed_ts": "1609109622083726",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21941",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c4cb86a6a8f3fbfd67bdb62887d51871936026d3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4cb86a6a8f3fbfd67bdb62887d51871936026d3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025150048317808704",
"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/8859719986185761376/+/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:50bf39d709602e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1609116390357558",
"url": "https://ci.chromium.org/b/8859719986185761376",
"utcnow_ts": "1609116390704653"
}
}
[00:46:30.711] Invocation finished in 1h52m51.297525681s with status FAILED