[16:48:30.759] New invocation is queued and will start shortly
[16:48:32.048] Starting the invocation (attempt 1)
[16:48:32.243] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:48:32.243] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:48:32.243] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019103024481122976",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d3f215517cc0d0fc2f88c44ac3d1e96459e83663\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9019103024481122976",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/d3f215517cc0d0fc2f88c44ac3d1e96459e83663",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d3f215517cc0d0fc2f88c44ac3d1e96459e83663",
"gitiles_ref:refs/heads/master"
]
}
[16:48:33.384] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614876512365405",
"id": "8853672962129113952",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d3f215517cc0d0fc2f88c44ac3d1e96459e83663\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614876513230682",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22864",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d3f215517cc0d0fc2f88c44ac3d1e96459e83663",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d3f215517cc0d0fc2f88c44ac3d1e96459e83663",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019103024481122976",
"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/8853672962129113952/+/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": "1614876513230787",
"url": "https://ci.chromium.org/b/8853672962129113952",
"utcnow_ts": "1614876513375669"
}
}
[16:48:33.384] Task URL: https://ci.chromium.org/b/8853672962129113952
[16:48:33.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:2:0) after 1m0s
[16:48:54.790] Received PubSub notification, asking Buildbucket for the build status
[16:48:55.339] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:33.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:2:0)
[16:49:33.426] Timer tick, asking Buildbucket for the build status
[16:49:33.570] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:33.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:4:0) after 1m0s
[16:50:33.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:4:0)
[16:50:33.575] Timer tick, asking Buildbucket for the build status
[16:50:33.649] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:33.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:5:0) after 1m0s
[16:51:33.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:5:0)
[16:51:33.728] Timer tick, asking Buildbucket for the build status
[16:51:33.843] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:33.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:6:0) after 1m0s
[16:52:33.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:6:0)
[16:52:33.918] Timer tick, asking Buildbucket for the build status
[16:52:35.092] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:35.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:7:0) after 1m0s
[16:53:35.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:7:0)
[16:53:35.407] Timer tick, asking Buildbucket for the build status
[16:53:37.936] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:37.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:8:0) after 1m0s
[16:54:38.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:8:0)
[16:54:38.447] Timer tick, asking Buildbucket for the build status
[16:54:38.862] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:38.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:9:0) after 1m0s
[16:55:38.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:9:0)
[16:55:38.846] Timer tick, asking Buildbucket for the build status
[16:55:39.078] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:39.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:10:0) after 1m0s
[16:56:39.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:10:0)
[16:56:39.274] Timer tick, asking Buildbucket for the build status
[16:56:39.395] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:39.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:11:0) after 1m0s
[16:57:39.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:11:0)
[16:57:39.520] Timer tick, asking Buildbucket for the build status
[16:57:39.590] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:39.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:12:0) after 1m0s
[16:58:39.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:12:0)
[16:58:39.678] Timer tick, asking Buildbucket for the build status
[16:58:39.789] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:39.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:13:0) after 1m0s
[16:59:41.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:13:0)
[16:59:41.145] Timer tick, asking Buildbucket for the build status
[16:59:41.205] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:41.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:14:0) after 1m0s
[17:00:41.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:14:0)
[17:00:41.232] Timer tick, asking Buildbucket for the build status
[17:00:41.363] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:41.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:15:0) after 1m0s
[17:01:41.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:15:0)
[17:01:41.421] Timer tick, asking Buildbucket for the build status
[17:01:41.625] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:41.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:16:0) after 1m0s
[17:02:41.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:16:0)
[17:02:41.667] Timer tick, asking Buildbucket for the build status
[17:02:43.569] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:43.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:17:0) after 1m0s
[17:03:43.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:17:0)
[17:03:43.629] Timer tick, asking Buildbucket for the build status
[17:03:43.699] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:43.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:18:0) after 1m0s
[17:04:43.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:18:0)
[17:04:43.834] Timer tick, asking Buildbucket for the build status
[17:04:44.304] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:44.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:19:0) after 1m0s
[17:05:44.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:19:0)
[17:05:44.402] Timer tick, asking Buildbucket for the build status
[17:05:44.805] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:44.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:20:0) after 1m0s
[17:06:44.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:20:0)
[17:06:44.874] Timer tick, asking Buildbucket for the build status
[17:06:44.938] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:44.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:21:0) after 1m0s
[17:07:45.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:21:0)
[17:07:45.012] Timer tick, asking Buildbucket for the build status
[17:07:45.098] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:45.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:22:0) after 1m0s
[17:08:45.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:22:0)
[17:08:45.238] Timer tick, asking Buildbucket for the build status
[17:08:45.323] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:45.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:23:0) after 1m0s
[17:09:45.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:23:0)
[17:09:45.385] Timer tick, asking Buildbucket for the build status
[17:09:45.670] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:45.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:24:0) after 1m0s
[17:10:46.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:24:0)
[17:10:46.009] Timer tick, asking Buildbucket for the build status
[17:10:46.092] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:46.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:25:0) after 1m0s
[17:11:47.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:25:0)
[17:11:47.000] Timer tick, asking Buildbucket for the build status
[17:11:49.661] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:49.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:26:0) after 1m0s
[17:12:50.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:26:0)
[17:12:50.498] Timer tick, asking Buildbucket for the build status
[17:12:50.973] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:50.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:27:0) after 1m0s
[17:13:51.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:27:0)
[17:13:51.451] Timer tick, asking Buildbucket for the build status
[17:13:51.529] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:51.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:28:0) after 1m0s
[17:14:51.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:28:0)
[17:14:51.823] Timer tick, asking Buildbucket for the build status
[17:14:51.911] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:51.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:29:0) after 1m0s
[17:15:52.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:29:0)
[17:15:52.015] Timer tick, asking Buildbucket for the build status
[17:15:52.085] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:52.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:30:0) after 1m0s
[17:16:52.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:30:0)
[17:16:52.189] Timer tick, asking Buildbucket for the build status
[17:16:52.303] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:52.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:31:0) after 1m0s
[17:17:52.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:31:0)
[17:17:52.517] Timer tick, asking Buildbucket for the build status
[17:17:52.580] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:52.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:32:0) after 1m0s
[17:18:52.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:32:0)
[17:18:52.600] Timer tick, asking Buildbucket for the build status
[17:18:52.757] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:52.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:33:0) after 1m0s
[17:19:52.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:33:0)
[17:19:52.805] Timer tick, asking Buildbucket for the build status
[17:19:52.908] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:52.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:34:0) after 1m0s
[17:20:52.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:34:0)
[17:20:52.950] Timer tick, asking Buildbucket for the build status
[17:20:53.167] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:53.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:35:0) after 1m0s
[17:21:53.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:35:0)
[17:21:53.433] Timer tick, asking Buildbucket for the build status
[17:21:53.652] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:53.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:36:0) after 1m0s
[17:22:53.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:36:0)
[17:22:53.825] Timer tick, asking Buildbucket for the build status
[17:22:53.901] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:53.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:37:0) after 1m0s
[17:23:53.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:37:0)
[17:23:53.986] Timer tick, asking Buildbucket for the build status
[17:23:54.667] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:54.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:38:0) after 1m0s
[17:24:54.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:38:0)
[17:24:54.798] Timer tick, asking Buildbucket for the build status
[17:24:54.900] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:54.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:39:0) after 1m0s
[17:25:54.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:39:0)
[17:25:54.971] Timer tick, asking Buildbucket for the build status
[17:25:55.490] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:55.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:40:0) after 1m0s
[17:26:55.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:40:0)
[17:26:55.463] Timer tick, asking Buildbucket for the build status
[17:26:55.706] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:55.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:41:0) after 1m0s
[17:27:55.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:41:0)
[17:27:55.725] Timer tick, asking Buildbucket for the build status
[17:27:55.808] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:55.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:42:0) after 1m0s
[17:28:55.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:42:0)
[17:28:55.955] Timer tick, asking Buildbucket for the build status
[17:28:56.085] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:56.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:43:0) after 1m0s
[17:29:56.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:43:0)
[17:29:56.156] Timer tick, asking Buildbucket for the build status
[17:29:56.238] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:56.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:44:0) after 1m0s
[17:30:56.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:44:0)
[17:30:56.328] Timer tick, asking Buildbucket for the build status
[17:30:56.669] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:56.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:45:0) after 1m0s
[17:31:56.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:45:0)
[17:31:56.797] Timer tick, asking Buildbucket for the build status
[17:31:56.950] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:56.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:46:0) after 1m0s
[17:32:56.991] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:46:0)
[17:32:56.991] Timer tick, asking Buildbucket for the build status
[17:32:57.100] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:57.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:47:0) after 1m0s
[17:33:57.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:47:0)
[17:33:57.478] Timer tick, asking Buildbucket for the build status
[17:33:57.653] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:57.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:48:0) after 1m0s
[17:34:57.817] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:48:0)
[17:34:57.817] Timer tick, asking Buildbucket for the build status
[17:34:57.994] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:57.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:49:0) after 1m0s
[17:35:58.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:49:0)
[17:35:58.007] Timer tick, asking Buildbucket for the build status
[17:35:58.824] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:58.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:50:0) after 1m0s
[17:36:59.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:50:0)
[17:36:59.066] Timer tick, asking Buildbucket for the build status
[17:36:59.563] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:59.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:51:0) after 1m0s
[17:37:59.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:51:0)
[17:37:59.633] Timer tick, asking Buildbucket for the build status
[17:37:59.779] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:59.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:52:0) after 1m0s
[17:38:59.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:52:0)
[17:38:59.878] Timer tick, asking Buildbucket for the build status
[17:38:59.997] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:59.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:53:0) after 1m0s
[17:40:00.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:53:0)
[17:40:00.067] Timer tick, asking Buildbucket for the build status
[17:40:00.843] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:00.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:54:0) after 1m0s
[17:41:00.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:54:0)
[17:41:00.902] Timer tick, asking Buildbucket for the build status
[17:41:01.295] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:01.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:55:0) after 1m0s
[17:42:01.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:55:0)
[17:42:01.482] Timer tick, asking Buildbucket for the build status
[17:42:02.158] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:02.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:56:0) after 1m0s
[17:43:02.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:56:0)
[17:43:02.156] Timer tick, asking Buildbucket for the build status
[17:43:02.245] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:02.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:57:0) after 1m0s
[17:44:02.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:57:0)
[17:44:02.244] Timer tick, asking Buildbucket for the build status
[17:44:02.345] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:02.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:58:0) after 1m0s
[17:45:02.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:58:0)
[17:45:02.478] Timer tick, asking Buildbucket for the build status
[17:45:02.690] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:02.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:59:0) after 1m0s
[17:46:02.898] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:59:0)
[17:46:02.898] Timer tick, asking Buildbucket for the build status
[17:46:03.076] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:03.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:60:0) after 1m0s
[17:47:03.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:60:0)
[17:47:03.176] Timer tick, asking Buildbucket for the build status
[17:47:03.717] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:03.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:61:0) after 1m0s
[17:48:04.100] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:61:0)
[17:48:04.100] Timer tick, asking Buildbucket for the build status
[17:48:04.914] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:04.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:62:0) after 1m0s
[17:49:05.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:62:0)
[17:49:05.121] Timer tick, asking Buildbucket for the build status
[17:49:05.272] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:05.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:63:0) after 1m0s
[17:50:05.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:63:0)
[17:50:05.501] Timer tick, asking Buildbucket for the build status
[17:50:05.643] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:05.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:64:0) after 1m0s
[17:51:05.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:64:0)
[17:51:05.813] Timer tick, asking Buildbucket for the build status
[17:51:05.927] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:05.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:65:0) after 1m0s
[17:52:06.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:65:0)
[17:52:06.004] Timer tick, asking Buildbucket for the build status
[17:52:06.092] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:06.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:66:0) after 1m0s
[17:53:06.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:66:0)
[17:53:06.102] Timer tick, asking Buildbucket for the build status
[17:53:06.210] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:06.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:67:0) after 1m0s
[17:54:06.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:67:0)
[17:54:06.276] Timer tick, asking Buildbucket for the build status
[17:54:06.370] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:06.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:68:0) after 1m0s
[17:55:06.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:68:0)
[17:55:06.431] Timer tick, asking Buildbucket for the build status
[17:55:06.530] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:06.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:69:0) after 1m0s
[17:56:06.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:69:0)
[17:56:06.563] Timer tick, asking Buildbucket for the build status
[17:56:06.909] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:06.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:70:0) after 1m0s
[17:57:07.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:70:0)
[17:57:07.001] Timer tick, asking Buildbucket for the build status
[17:57:07.145] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:07.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:71:0) after 1m0s
[17:58:07.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:71:0)
[17:58:07.183] Timer tick, asking Buildbucket for the build status
[17:58:07.343] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:07.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:72:0) after 1m0s
[17:59:07.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:72:0)
[17:59:07.422] Timer tick, asking Buildbucket for the build status
[17:59:07.547] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:07.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:73:0) after 1m0s
[18:00:07.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:73:0)
[18:00:07.526] Timer tick, asking Buildbucket for the build status
[18:00:07.622] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:07.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:74:0) after 1m0s
[18:01:07.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:74:0)
[18:01:07.663] Timer tick, asking Buildbucket for the build status
[18:01:07.951] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:07.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:75:0) after 1m0s
[18:02:08.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:75:0)
[18:02:08.015] Timer tick, asking Buildbucket for the build status
[18:02:08.139] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:08.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:76:0) after 1m0s
[18:03:08.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:76:0)
[18:03:08.174] Timer tick, asking Buildbucket for the build status
[18:03:08.248] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:08.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:77:0) after 1m0s
[18:04:08.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:77:0)
[18:04:08.288] Timer tick, asking Buildbucket for the build status
[18:04:08.624] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:08.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:78:0) after 1m0s
[18:05:08.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:78:0)
[18:05:08.667] Timer tick, asking Buildbucket for the build status
[18:05:08.803] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:08.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:79:0) after 1m0s
[18:06:08.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:79:0)
[18:06:08.824] Timer tick, asking Buildbucket for the build status
[18:06:08.915] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:08.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:80:0) after 1m0s
[18:07:09.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:80:0)
[18:07:09.063] Timer tick, asking Buildbucket for the build status
[18:07:11.129] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:11.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:81:0) after 1m0s
[18:08:11.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:81:0)
[18:08:11.134] Timer tick, asking Buildbucket for the build status
[18:08:11.247] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:11.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:82:0) after 1m0s
[18:09:11.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:82:0)
[18:09:11.330] Timer tick, asking Buildbucket for the build status
[18:09:11.450] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:11.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:83:0) after 1m0s
[18:10:11.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:83:0)
[18:10:11.456] Timer tick, asking Buildbucket for the build status
[18:10:11.585] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:11.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:84:0) after 1m0s
[18:11:11.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:84:0)
[18:11:11.620] Timer tick, asking Buildbucket for the build status
[18:11:14.373] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:14.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:85:0) after 1m0s
[18:12:14.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:85:0)
[18:12:14.875] Timer tick, asking Buildbucket for the build status
[18:12:21.065] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:21.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:86:0) after 1m0s
[18:13:21.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:86:0)
[18:13:21.292] Timer tick, asking Buildbucket for the build status
[18:13:21.392] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:21.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:87:0) after 1m0s
[18:14:21.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:87:0)
[18:14:21.464] Timer tick, asking Buildbucket for the build status
[18:14:21.573] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:21.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:88:0) after 1m0s
[18:15:21.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:88:0)
[18:15:21.675] Timer tick, asking Buildbucket for the build status
[18:15:21.752] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:21.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:89:0) after 1m0s
[18:16:21.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:89:0)
[18:16:21.811] Timer tick, asking Buildbucket for the build status
[18:16:21.913] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:21.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:90:0) after 1m0s
[18:17:21.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:90:0)
[18:17:21.955] Timer tick, asking Buildbucket for the build status
[18:17:22.062] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:22.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:91:0) after 1m0s
[18:18:22.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:91:0)
[18:18:22.410] Timer tick, asking Buildbucket for the build status
[18:18:22.537] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:22.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:92:0) after 1m0s
[18:19:22.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:92:0)
[18:19:22.581] Timer tick, asking Buildbucket for the build status
[18:19:23.121] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:23.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:93:0) after 1m0s
[18:20:23.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:93:0)
[18:20:23.131] Timer tick, asking Buildbucket for the build status
[18:20:23.269] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:23.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:94:0) after 1m0s
[18:21:23.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:94:0)
[18:21:23.293] Timer tick, asking Buildbucket for the build status
[18:21:23.606] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:23.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:95:0) after 1m0s
[18:22:23.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:95:0)
[18:22:23.605] Timer tick, asking Buildbucket for the build status
[18:22:23.697] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:23.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:96:0) after 1m0s
[18:23:23.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:96:0)
[18:23:23.714] Timer tick, asking Buildbucket for the build status
[18:23:24.109] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:24.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:97:0) after 1m0s
[18:24:24.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:97:0)
[18:24:24.135] Timer tick, asking Buildbucket for the build status
[18:24:24.413] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:24.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:98:0) after 1m0s
[18:25:24.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:98:0)
[18:25:24.438] Timer tick, asking Buildbucket for the build status
[18:25:25.146] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:25.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:99:0) after 1m0s
[18:26:25.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:99:0)
[18:26:25.419] Timer tick, asking Buildbucket for the build status
[18:26:25.977] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:25.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:100:0) after 1m0s
[18:27:26.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:100:0)
[18:27:26.032] Timer tick, asking Buildbucket for the build status
[18:27:26.434] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:26.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:101:0) after 1m0s
[18:28:26.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:101:0)
[18:28:26.510] Timer tick, asking Buildbucket for the build status
[18:28:26.632] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:26.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:102:0) after 1m0s
[18:29:26.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:102:0)
[18:29:26.660] Timer tick, asking Buildbucket for the build status
[18:29:27.209] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:27.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:103:0) after 1m0s
[18:30:27.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:103:0)
[18:30:27.334] Timer tick, asking Buildbucket for the build status
[18:30:27.758] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:27.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:104:0) after 1m0s
[18:31:27.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:104:0)
[18:31:27.766] Timer tick, asking Buildbucket for the build status
[18:31:28.150] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:28.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:105:0) after 1m0s
[18:32:28.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:105:0)
[18:32:28.185] Timer tick, asking Buildbucket for the build status
[18:32:28.276] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:28.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:106:0) after 1m0s
[18:33:28.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:106:0)
[18:33:28.274] Timer tick, asking Buildbucket for the build status
[18:33:28.359] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:28.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:107:0) after 1m0s
[18:34:28.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:107:0)
[18:34:28.408] Timer tick, asking Buildbucket for the build status
[18:34:28.527] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:28.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:108:0) after 1m0s
[18:35:28.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:108:0)
[18:35:28.551] Timer tick, asking Buildbucket for the build status
[18:35:28.650] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:28.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:109:0) after 1m0s
[18:36:28.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:109:0)
[18:36:28.674] Timer tick, asking Buildbucket for the build status
[18:36:29.041] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:29.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:110:0) after 1m0s
[18:37:29.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:110:0)
[18:37:29.065] Timer tick, asking Buildbucket for the build status
[18:37:29.148] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:29.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:111:0) after 1m0s
[18:38:29.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:111:0)
[18:38:29.536] Timer tick, asking Buildbucket for the build status
[18:38:30.016] Build 8853672962129113952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:30.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019103024481122976:112:0) after 1m0s
[18:38:45.858] Received PubSub notification, asking Buildbucket for the build status
[18:38:46.161] Build 8853672962129113952: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:38:46.161] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614883123188375",
"created_by": "project:chromium",
"created_ts": "1614876512365405",
"id": "8853672962129113952",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d3f215517cc0d0fc2f88c44ac3d1e96459e83663\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"d3f215517cc0d0fc2f88c44ac3d1e96459e83663\", \"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-99-xbqj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22864, \"got_angle_revision\": \"90db604919ba6e3a5ffbdd43845ac33f91e7ddfa\", \"got_dawn_revision\": \"d9a96fb28648eaff2c54beca62f14c718f042217\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"d3f215517cc0d0fc2f88c44ac3d1e96459e83663\", \"got_revision_cp\": \"refs/heads/master@{#859802}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"084529f3a9b9992a0de73fe333f677bced7b8fdb\", \"got_v8_revision\": \"5134dc63648b2cf1d5f95604dc1d87520f121443\", \"got_v8_revision_cp\": \"refs/heads/9.1.44@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"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\": \"d3f215517cc0d0fc2f88c44ac3d1e96459e83663\", \"swarm_hashes_refs/heads/master(at){#859802}_without_patch\": {\"absl_hardening_tests\": \"a8ac2da1fa287ec98058d1945c116f1a39544d88\", \"accessibility_unittests\": \"cd4179c6908cd054eab0fc712eccbe917b8ffcfa\", \"angle_unittests\": \"0fde49c965ab18322f629ac0f957ab71b2e382c4\", \"app_list_unittests\": \"8de12a2d1d30505ee13d4fe836cea3a3bc0866bd\", \"app_shell_unittests\": \"98839080b0a9854eff55486ec73512ccf7d17c4c\", \"ash_unittests\": \"585e1a417a548442a9608e3fef193eccd85c11f8\", \"aura_unittests\": \"a94f6f567d54c935b1b240d36d1a6422c8abb4d9\", \"base_unittests\": \"1a92bd0f42d6f51e479d00ca22090dbf2c3a8d95\", \"base_util_unittests\": \"7d0c0f5e3dfb218dc31e20b92950f7076471348f\", \"blink_common_unittests\": \"c612d549648119c9a11270a4f2a6f73b2a59646a\", \"blink_fuzzer_unittests\": \"6fbd67b8992f18e2eeb843be7817bea8628c478c\", \"blink_heap_unittests\": \"2f183b7cacf63470fa1fe3837cfdb4bc8620ca91\", \"blink_platform_unittests\": \"2ea97f7856d8cfcccc7b2f82de4e0123e2f9357b\", \"blink_unittests\": \"85123b5823270de0310ff5913f45a5a87dfb4047\", \"boringssl_crypto_tests\": \"f38d4b3c14da5e90c5d078605ad3b9d033998283\", \"boringssl_ssl_tests\": \"193908b8829703cecbfdfb1e073074b7aff319d6\", \"browser_tests\": \"ecaa5e76a744233189f8a6d710bd8b23f902d7fb\", \"capture_unittests\": \"61bb56a12f980be1377313b81e34eddec529f03d\", \"cast_unittests\": \"8edd449285d29da3ad5f4a84b19514b01b0b54b0\", \"cc_unittests\": \"6ffa120ef6ff10f61ac8e5cef1df620879a08741\", \"chrome_app_unittests\": \"f59bef35966fbdcb292436bbc089f9bb5ca46153\", \"chromedriver_unittests\": \"efdb2373dc3653970db603455361c143880926f9\", \"chromeos_components_unittests\": \"8c562389b74ed8a446bc96c443cd7cef82130bf0\", \"chromeos_unittests\": \"8133726481bf08cf591f4f602d659a58f54c81f9\", \"color_unittests\": \"4cec395fe189afe349e55a996b088d89bb4e3022\", \"components_browsertests\": \"b1e54e2f465b54d2941d325e24eb6b372c88a052\", \"components_unittests\": \"27205eab0e86b7bd940bdd2d3c41e3e686554e65\", \"compositor_unittests\": \"0a069f3fee577d0beb0ff7b7c83c523555e03742\", \"content_browsertests\": \"4fa0f6cdcef433c13ec8a52e631ece9d6d093982\", \"content_unittests\": \"b82ae549ba5280710991f6cc13415106fa8618f3\", \"crashpad_tests\": \"e5d44125ee951bdecdc49d99a7dc5440e02812f1\", \"crypto_unittests\": \"dc012507dd4b661dcfbe0829a5a41500c4639750\", \"dbus_unittests\": \"8959aaa57b557064ba3b2f0bef2d1e09b0148ff7\", \"device_unittests\": \"897a9ddaa801c29dd11b54e7e9649c3dfff721d8\", \"display_unittests\": \"726561f7fd8046c97f41320766f34ec43434613e\", \"events_unittests\": \"a0840359936f63323c6d5b3895b33ded31a78ab8\", \"exo_unittests\": \"b75643746aaee4d15cf6ffbe2cffb024b35400d0\", \"extensions_browsertests\": \"518b5b3cc08bc16985ae9153fe4fb096b63ed381\", \"extensions_unittests\": \"24c73b3fed57bd3b375c2e3c009426226d3aca47\", \"filesystem_service_unittests\": \"cf918ba8e29a559211b8093fcc5f67e657337dba\", \"gcm_unit_tests\": \"4ea0666b796f37c6554770ab3a68f794dbfe9d81\", \"gfx_unittests\": \"8620a706a916057cac06c34525129461137e2296\", \"gin_unittests\": \"3b23a75e2f0e27ca8913724dd404ee933e53805f\", \"gl_unittests_ozone\": \"289787353d26f2feba5c4ed3501942e817fb113c\", \"google_apis_unittests\": \"86b7628900c00db47ce7dac7b7da7b63bdcebd08\", \"gpu_unittests\": \"faf99724fca65ebd21449aad4616ec86cfa0e570\", \"gwp_asan_unittests\": \"cd29b77e4d1fb02a1c8d3288716ea694f245e385\", \"interactive_ui_tests\": \"4a8073c17f5886ea8cf2feae65fe042cf9bd9e61\", \"ipc_tests\": \"3db5a500b3d55547ccafe81623821047561aadfb\", \"jingle_unittests\": \"f9872e378ef13d421ba0c7fbb619335bfcd40aaf\", \"keyboard_unittests\": \"315e16247de3bdb91fa7865a663baa73c00cd4b9\", \"latency_unittests\": \"b6971dc54037115fadb6086b4ca3d834dbe0ec2b\", \"libjingle_xmpp_unittests\": \"33bf6d295068ba1e86ffac4e10487f500e6b72f7\", \"liburlpattern_unittests\": \"c1a508914391a8ca7d68c8daf48350c5660e4d50\", \"media_blink_unittests\": \"ce1e4d0514162af6c1617c16cd0244541aa67e24\", \"media_unittests\": \"6aff9776c070f57f4aba8563caf8b6f29b0a5639\", \"message_center_unittests\": \"d99ef63d6f03b10340bd7ac6ecf67a5f684e80c3\", \"midi_unittests\": \"3d0542b82adfbd25f3e3029ac4209cbe9f23b95a\", \"mojo_core_unittests\": \"bb6eb35bdf70d99da2bad4c8f37e50bd3e5411dd\", \"mojo_unittests\": \"1d4d464569edff5a49dcf880e7d6123d9e3599f8\", \"nacl_helper_nonsfi_unittests\": \"8c6eac6f73f5a6b0ce41dfca7d26a7116024c020\", \"nacl_loader_unittests\": \"4df85cf5759d55d42f876e2f205730c9a7882845\", \"native_theme_unittests\": \"a5bb96f1d69a7781569a0a9177655a871da73dcf\", \"net_unittests\": \"7d485681a8cc5103b7e33607bae9b3fee714b75a\", \"ozone_gl_unittests\": \"c3ee6c794202f70457190003ee9c20423543a61e\", \"ozone_unittests\": \"d09655841675466fd7b47d92b6ab10d8aa282131\", \"ozone_x11_unittests\": \"ba819e414b0068d9a19709d1e2dec98c3dd99136\", \"pdf_unittests\": \"ab71bf3a44b32ead94f6f97938fa609fc4bd2281\", \"perfetto_unittests\": \"37d37d680e096a9cfa35935b17c931b945f41053\", \"ppapi_unittests\": \"2c96e6c16676ccf1132bfe8955920d32908a2617\", \"printing_unittests\": \"b9bde3d9bca346618c8b62ce601b89a98ed5d545\", \"remoting_unittests\": \"4b0bc2b498551d32dcfa2e930730b8a6ae705653\", \"sandbox_linux_unittests\": \"6293a3d2da9ef561a0b68fb8b16ff8b7c2bd5f44\", \"service_manager_unittests\": \"f3fa45a0223d95dbb7d633b7ce943db0984559ed\", \"services_unittests\": \"e5f0cb12dff1c5f8caca8e86294cd7de331c727f\", \"shell_dialogs_unittests\": \"01db53e565b929eca48caeb3afeb1f5a038b2449\", \"shell_encryption_unittests\": \"937a59fe2196b16976fa08b634470881de0afc01\", \"skia_unittests\": \"6f920a86a490ffd4475381bbf2b9bf4f14537790\", \"snapshot_unittests\": \"2bc1faf3dfabc18bf8cbf28cf329a8fc7de72f38\", \"sql_unittests\": \"521345e6e38827d49c07d7f6993edfc30c6dd792\", \"storage_unittests\": \"2c73c366b0802855a4ae77e47f98c7c56e8984c8\", \"sync_integration_tests\": \"965aaefcd8b540d6614655a029579500f3470f9f\", \"traffic_annotation_auditor_unittests\": \"091922938a140df762b5950db41177c3fbf04051\", \"ui_base_unittests\": \"76ff2e3c088408b2bcc70e2ebb2ff55bdbd17770\", \"ui_chromeos_unittests\": \"c8688e1e6942eb01774d7897f95f22e97df7bfa8\", \"ui_touch_selection_unittests\": \"49eb9e1013b0e4f65881c845541db43cbd37c78b\", \"unit_tests\": \"95f2245b367762d95a064409f18411418883e52d\", \"url_unittests\": \"1eff9e859a01a99471797f8fe26cd2798c54e09b\", \"usage_time_limit_unittests\": \"914a55574a1b23748c11a838e51bfea5a31b7d96\", \"views_unittests\": \"9673dde7261369a74a5fdd3ebb4341cab2e9205a\", \"viz_unittests\": \"68e3afe6beaa858a0873a42bcdfb954d775af783\", \"wayland_client_tests\": \"f575866ea9e057c2581b1fc3e6309f28af92f388\", \"wm_unittests\": \"d8d097ddd34cba3ae39be51cfb7eb3b6d18e1437\", \"wtf_unittests\": \"9c0ebef0c2cbdd3ecf9fb823e8f6f0f9782eb8ae\", \"zlib_unittests\": \"23a56db31b5b6fb542bef7ab112b7d56fb621f25\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_5f931a5519f78feef046af549827aa56dc2e9b17853b60b3d0ae8ebd533780ee_v2\", \"builder_b224075beee246a5ffe9706a23163fae567137407ac5f1b69c50b4dcd22edd9b_v2\", \"builder_e5bbff72983945f6847543519ce1052420cedd06fb8495f4080bfa2e6bcfd13f_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-east1-d-8-99-xbqj\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5725-1a0d85e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614876533777476",
"status": "COMPLETED",
"status_changed_ts": "1614883123550728",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22864",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d3f215517cc0d0fc2f88c44ac3d1e96459e83663",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d3f215517cc0d0fc2f88c44ac3d1e96459e83663",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019103024481122976",
"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/8853672962129113952/+/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:5216f59d121d8410",
"user_agent:luci-scheduler"
],
"updated_ts": "1614883123555515",
"url": "https://ci.chromium.org/b/8853672962129113952",
"utcnow_ts": "1614883126142502"
}
}
[18:38:46.161] Invocation finished in 1h50m15.422331249s with status SUCCEEDED