[10:29:49.763] New invocation is queued and will start shortly
[10:29:51.002] Starting the invocation (attempt 1)
[10:29:51.046] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:29:51.046] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:29:51.046] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022297742989222000",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a1a3ba318c217883f25999867881e9514304edfc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9022297742989222000",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/a1a3ba318c217883f25999867881e9514304edfc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a1a3ba318c217883f25999867881e9514304edfc",
"gitiles_ref:refs/heads/master"
]
}
[10:29:51.885] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611829791173433",
"id": "8856867680849194048",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a1a3ba318c217883f25999867881e9514304edfc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611829791746753",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22381",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a1a3ba318c217883f25999867881e9514304edfc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a1a3ba318c217883f25999867881e9514304edfc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022297742989222000",
"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/8856867680849194048/+/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": "1611829791746899",
"url": "https://ci.chromium.org/b/8856867680849194048",
"utcnow_ts": "1611829791873188"
}
}
[10:29:51.885] Task URL: https://ci.chromium.org/b/8856867680849194048
[10:29:51.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:2:0) after 1m0s
[10:29:54.251] Received PubSub notification, asking Buildbucket for the build status
[10:29:54.336] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:52.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:2:0)
[10:30:52.011] Timer tick, asking Buildbucket for the build status
[10:30:52.176] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:52.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:4:0) after 1m0s
[10:31:52.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:4:0)
[10:31:52.389] Timer tick, asking Buildbucket for the build status
[10:31:52.683] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:52.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:5:0) after 1m0s
[10:32:52.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:5:0)
[10:32:52.767] Timer tick, asking Buildbucket for the build status
[10:32:52.889] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:52.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:6:0) after 1m0s
[10:33:52.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:6:0)
[10:33:52.950] Timer tick, asking Buildbucket for the build status
[10:33:53.411] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:53.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:7:0) after 1m0s
[10:34:53.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:7:0)
[10:34:53.465] Timer tick, asking Buildbucket for the build status
[10:34:53.642] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:53.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:8:0) after 1m0s
[10:35:53.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:8:0)
[10:35:53.786] Timer tick, asking Buildbucket for the build status
[10:35:54.691] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:54.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:9:0) after 1m0s
[10:36:54.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:9:0)
[10:36:54.908] Timer tick, asking Buildbucket for the build status
[10:36:54.976] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:54.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:10:0) after 1m0s
[10:37:55.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:10:0)
[10:37:55.055] Timer tick, asking Buildbucket for the build status
[10:37:55.112] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:55.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:11:0) after 1m0s
[10:38:55.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:11:0)
[10:38:55.152] Timer tick, asking Buildbucket for the build status
[10:38:55.428] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:55.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:12:0) after 1m0s
[10:39:55.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:12:0)
[10:39:55.447] Timer tick, asking Buildbucket for the build status
[10:39:55.718] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:55.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:13:0) after 1m0s
[10:40:55.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:13:0)
[10:40:55.807] Timer tick, asking Buildbucket for the build status
[10:40:55.959] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:55.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:14:0) after 1m0s
[10:41:56.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:14:0)
[10:41:56.021] Timer tick, asking Buildbucket for the build status
[10:41:56.396] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:56.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:15:0) after 1m0s
[10:42:56.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:15:0)
[10:42:56.459] Timer tick, asking Buildbucket for the build status
[10:42:56.522] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:56.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:16:0) after 1m0s
[10:43:56.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:16:0)
[10:43:56.564] Timer tick, asking Buildbucket for the build status
[10:43:56.645] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:56.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:17:0) after 1m0s
[10:44:56.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:17:0)
[10:44:56.689] Timer tick, asking Buildbucket for the build status
[10:44:56.797] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:56.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:18:0) after 1m0s
[10:45:56.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:18:0)
[10:45:56.893] Timer tick, asking Buildbucket for the build status
[10:45:56.969] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:56.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:19:0) after 1m0s
[10:46:57.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:19:0)
[10:46:57.018] Timer tick, asking Buildbucket for the build status
[10:46:57.279] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:57.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:20:0) after 1m0s
[10:47:57.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:20:0)
[10:47:57.379] Timer tick, asking Buildbucket for the build status
[10:47:57.462] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:57.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:21:0) after 1m0s
[10:48:57.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:21:0)
[10:48:57.478] Timer tick, asking Buildbucket for the build status
[10:48:57.539] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:57.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:22:0) after 1m0s
[10:49:57.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:22:0)
[10:49:57.543] Timer tick, asking Buildbucket for the build status
[10:49:57.652] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:57.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:23:0) after 1m0s
[10:50:57.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:23:0)
[10:50:57.740] Timer tick, asking Buildbucket for the build status
[10:50:57.838] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:57.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:24:0) after 1m0s
[10:51:57.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:24:0)
[10:51:57.854] Timer tick, asking Buildbucket for the build status
[10:51:57.934] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:57.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:25:0) after 1m0s
[10:52:57.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:25:0)
[10:52:57.964] Timer tick, asking Buildbucket for the build status
[10:52:58.036] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:58.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:26:0) after 1m0s
[10:53:58.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:26:0)
[10:53:58.058] Timer tick, asking Buildbucket for the build status
[10:53:58.142] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:58.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:27:0) after 1m0s
[10:54:58.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:27:0)
[10:54:58.175] Timer tick, asking Buildbucket for the build status
[10:54:58.293] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:58.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:28:0) after 1m0s
[10:55:58.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:28:0)
[10:55:58.308] Timer tick, asking Buildbucket for the build status
[10:55:58.392] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:58.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:29:0) after 1m0s
[10:56:58.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:29:0)
[10:56:58.487] Timer tick, asking Buildbucket for the build status
[10:56:58.564] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:58.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:30:0) after 1m0s
[10:57:58.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:30:0)
[10:57:58.568] Timer tick, asking Buildbucket for the build status
[10:57:58.636] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:58.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:31:0) after 1m0s
[10:58:58.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:31:0)
[10:58:58.704] Timer tick, asking Buildbucket for the build status
[10:58:58.763] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:58.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:32:0) after 1m0s
[10:59:58.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:32:0)
[10:59:58.847] Timer tick, asking Buildbucket for the build status
[10:59:59.031] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:59.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:33:0) after 1m0s
[11:00:59.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:33:0)
[11:00:59.145] Timer tick, asking Buildbucket for the build status
[11:00:59.200] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:59.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:34:0) after 1m0s
[11:01:59.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:34:0)
[11:01:59.301] Timer tick, asking Buildbucket for the build status
[11:01:59.372] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:59.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:35:0) after 1m0s
[11:02:59.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:35:0)
[11:02:59.444] Timer tick, asking Buildbucket for the build status
[11:02:59.519] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:59.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:36:0) after 1m0s
[11:03:59.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:36:0)
[11:03:59.587] Timer tick, asking Buildbucket for the build status
[11:03:59.995] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:59.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:37:0) after 1m0s
[11:05:00.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:37:0)
[11:05:00.064] Timer tick, asking Buildbucket for the build status
[11:05:00.403] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:00.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:38:0) after 1m0s
[11:06:00.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:38:0)
[11:06:00.401] Timer tick, asking Buildbucket for the build status
[11:06:00.559] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:00.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:39:0) after 1m0s
[11:07:01.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:39:0)
[11:07:01.506] Timer tick, asking Buildbucket for the build status
[11:07:02.176] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:02.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:40:0) after 1m0s
[11:08:02.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:40:0)
[11:08:02.229] Timer tick, asking Buildbucket for the build status
[11:08:02.395] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:02.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:41:0) after 1m0s
[11:09:02.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:41:0)
[11:09:02.459] Timer tick, asking Buildbucket for the build status
[11:09:02.575] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:02.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:42:0) after 1m0s
[11:10:02.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:42:0)
[11:10:02.615] Timer tick, asking Buildbucket for the build status
[11:10:02.781] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:02.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:43:0) after 1m0s
[11:11:02.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:43:0)
[11:11:02.779] Timer tick, asking Buildbucket for the build status
[11:11:02.900] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:02.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:44:0) after 1m0s
[11:12:02.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:44:0)
[11:12:02.960] Timer tick, asking Buildbucket for the build status
[11:12:03.022] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:03.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:45:0) after 1m0s
[11:13:03.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:45:0)
[11:13:03.044] Timer tick, asking Buildbucket for the build status
[11:13:03.151] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:03.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:46:0) after 1m0s
[11:14:03.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:46:0)
[11:14:03.193] Timer tick, asking Buildbucket for the build status
[11:14:03.425] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:03.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:47:0) after 1m0s
[11:15:03.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:47:0)
[11:15:03.478] Timer tick, asking Buildbucket for the build status
[11:15:03.991] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:03.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:48:0) after 1m0s
[11:16:04.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:48:0)
[11:16:04.001] Timer tick, asking Buildbucket for the build status
[11:16:04.165] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:04.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:49:0) after 1m0s
[11:17:04.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:49:0)
[11:17:04.207] Timer tick, asking Buildbucket for the build status
[11:17:04.353] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:04.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:50:0) after 1m0s
[11:18:04.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:50:0)
[11:18:04.386] Timer tick, asking Buildbucket for the build status
[11:18:04.549] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:04.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:51:0) after 1m0s
[11:19:04.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:51:0)
[11:19:04.575] Timer tick, asking Buildbucket for the build status
[11:19:04.735] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:04.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:52:0) after 1m0s
[11:20:04.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:52:0)
[11:20:04.853] Timer tick, asking Buildbucket for the build status
[11:20:05.426] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:05.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:53:0) after 1m0s
[11:21:05.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:53:0)
[11:21:05.454] Timer tick, asking Buildbucket for the build status
[11:21:05.624] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:05.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:54:0) after 1m0s
[11:22:05.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:54:0)
[11:22:05.672] Timer tick, asking Buildbucket for the build status
[11:22:05.803] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:05.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:55:0) after 1m0s
[11:23:05.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:55:0)
[11:23:05.796] Timer tick, asking Buildbucket for the build status
[11:23:07.334] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:07.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:56:0) after 1m0s
[11:24:07.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:56:0)
[11:24:07.378] Timer tick, asking Buildbucket for the build status
[11:24:08.209] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:08.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:57:0) after 1m0s
[11:25:08.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:57:0)
[11:25:08.327] Timer tick, asking Buildbucket for the build status
[11:25:08.467] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:08.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:58:0) after 1m0s
[11:26:08.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:58:0)
[11:26:08.564] Timer tick, asking Buildbucket for the build status
[11:26:08.762] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:08.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:59:0) after 1m0s
[11:27:08.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:59:0)
[11:27:08.840] Timer tick, asking Buildbucket for the build status
[11:27:08.912] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:08.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:60:0) after 1m0s
[11:28:09.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:60:0)
[11:28:09.000] Timer tick, asking Buildbucket for the build status
[11:28:09.066] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:09.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:61:0) after 1m0s
[11:29:09.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:61:0)
[11:29:09.125] Timer tick, asking Buildbucket for the build status
[11:29:09.218] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:09.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:62:0) after 1m0s
[11:30:09.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:62:0)
[11:30:09.313] Timer tick, asking Buildbucket for the build status
[11:30:09.464] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:09.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:63:0) after 1m0s
[11:31:09.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:63:0)
[11:31:09.491] Timer tick, asking Buildbucket for the build status
[11:31:09.781] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:09.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:64:0) after 1m0s
[11:32:09.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:64:0)
[11:32:09.803] Timer tick, asking Buildbucket for the build status
[11:32:09.945] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:09.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:65:0) after 1m0s
[11:33:10.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:65:0)
[11:33:10.138] Timer tick, asking Buildbucket for the build status
[11:33:10.280] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:10.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:66:0) after 1m0s
[11:34:10.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:66:0)
[11:34:10.455] Timer tick, asking Buildbucket for the build status
[11:34:10.934] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:10.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:67:0) after 1m0s
[11:35:11.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:67:0)
[11:35:11.054] Timer tick, asking Buildbucket for the build status
[11:35:11.195] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:11.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:68:0) after 1m0s
[11:36:11.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:68:0)
[11:36:11.595] Timer tick, asking Buildbucket for the build status
[11:36:11.741] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:11.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:69:0) after 1m0s
[11:37:12.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:69:0)
[11:37:12.166] Timer tick, asking Buildbucket for the build status
[11:37:12.242] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:12.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:70:0) after 1m0s
[11:38:12.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:70:0)
[11:38:12.307] Timer tick, asking Buildbucket for the build status
[11:38:12.431] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:12.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:71:0) after 1m0s
[11:39:12.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:71:0)
[11:39:12.818] Timer tick, asking Buildbucket for the build status
[11:39:12.971] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:12.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:72:0) after 1m0s
[11:40:12.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:72:0)
[11:40:12.998] Timer tick, asking Buildbucket for the build status
[11:40:13.097] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:13.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:73:0) after 1m0s
[11:41:13.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:73:0)
[11:41:13.236] Timer tick, asking Buildbucket for the build status
[11:41:13.309] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:13.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:74:0) after 1m0s
[11:42:13.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:74:0)
[11:42:13.598] Timer tick, asking Buildbucket for the build status
[11:42:13.689] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:13.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:75:0) after 1m0s
[11:43:13.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:75:0)
[11:43:13.810] Timer tick, asking Buildbucket for the build status
[11:43:13.871] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:13.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:76:0) after 1m0s
[11:44:14.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:76:0)
[11:44:14.079] Timer tick, asking Buildbucket for the build status
[11:44:14.603] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:14.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:77:0) after 1m0s
[11:45:14.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:77:0)
[11:45:14.691] Timer tick, asking Buildbucket for the build status
[11:45:15.116] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:15.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:78:0) after 1m0s
[11:46:15.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:78:0)
[11:46:15.206] Timer tick, asking Buildbucket for the build status
[11:46:15.288] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:15.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:79:0) after 1m0s
[11:47:15.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:79:0)
[11:47:15.389] Timer tick, asking Buildbucket for the build status
[11:47:16.017] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:16.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:80:0) after 1m0s
[11:48:16.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:80:0)
[11:48:16.198] Timer tick, asking Buildbucket for the build status
[11:48:16.271] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:16.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:81:0) after 1m0s
[11:49:16.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:81:0)
[11:49:16.422] Timer tick, asking Buildbucket for the build status
[11:49:16.481] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:16.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:82:0) after 1m0s
[11:50:16.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:82:0)
[11:50:16.525] Timer tick, asking Buildbucket for the build status
[11:50:16.864] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:16.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:83:0) after 1m0s
[11:51:16.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:83:0)
[11:51:16.929] Timer tick, asking Buildbucket for the build status
[11:51:17.362] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:17.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:84:0) after 1m0s
[11:52:17.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:84:0)
[11:52:17.384] Timer tick, asking Buildbucket for the build status
[11:52:18.137] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:18.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:85:0) after 1m0s
[11:53:18.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:85:0)
[11:53:18.121] Timer tick, asking Buildbucket for the build status
[11:53:18.204] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:18.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:86:0) after 1m0s
[11:54:18.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:86:0)
[11:54:18.211] Timer tick, asking Buildbucket for the build status
[11:54:18.292] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:18.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:87:0) after 1m0s
[11:55:18.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:87:0)
[11:55:18.370] Timer tick, asking Buildbucket for the build status
[11:55:18.484] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:18.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:88:0) after 1m0s
[11:56:18.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:88:0)
[11:56:18.581] Timer tick, asking Buildbucket for the build status
[11:56:18.738] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:18.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:89:0) after 1m0s
[11:57:18.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:89:0)
[11:57:18.945] Timer tick, asking Buildbucket for the build status
[11:57:19.016] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:19.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:90:0) after 1m0s
[11:58:19.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:90:0)
[11:58:19.046] Timer tick, asking Buildbucket for the build status
[11:58:19.123] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:19.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:91:0) after 1m0s
[11:59:19.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:91:0)
[11:59:19.265] Timer tick, asking Buildbucket for the build status
[11:59:19.631] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:19.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:92:0) after 1m0s
[12:00:19.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:92:0)
[12:00:19.729] Timer tick, asking Buildbucket for the build status
[12:00:20.020] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:20.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:93:0) after 1m0s
[12:01:20.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:93:0)
[12:01:20.039] Timer tick, asking Buildbucket for the build status
[12:01:20.127] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:20.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:94:0) after 1m0s
[12:02:20.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:94:0)
[12:02:20.195] Timer tick, asking Buildbucket for the build status
[12:02:20.313] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:20.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:95:0) after 1m0s
[12:03:20.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:95:0)
[12:03:20.347] Timer tick, asking Buildbucket for the build status
[12:03:20.435] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:20.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:96:0) after 1m0s
[12:04:20.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:96:0)
[12:04:20.572] Timer tick, asking Buildbucket for the build status
[12:04:20.636] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:20.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:97:0) after 1m0s
[12:05:20.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:97:0)
[12:05:20.672] Timer tick, asking Buildbucket for the build status
[12:05:20.870] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:20.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:98:0) after 1m0s
[12:06:20.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:98:0)
[12:06:20.906] Timer tick, asking Buildbucket for the build status
[12:06:20.986] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:20.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:99:0) after 1m0s
[12:07:21.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:99:0)
[12:07:21.021] Timer tick, asking Buildbucket for the build status
[12:07:21.154] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:21.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:100:0) after 1m0s
[12:08:21.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:100:0)
[12:08:21.174] Timer tick, asking Buildbucket for the build status
[12:08:21.302] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:21.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:101:0) after 1m0s
[12:09:21.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:101:0)
[12:09:21.352] Timer tick, asking Buildbucket for the build status
[12:09:21.457] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:21.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:102:0) after 1m0s
[12:10:21.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:102:0)
[12:10:21.493] Timer tick, asking Buildbucket for the build status
[12:10:21.847] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:21.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:103:0) after 1m0s
[12:11:21.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:103:0)
[12:11:21.920] Timer tick, asking Buildbucket for the build status
[12:11:22.891] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:22.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:104:0) after 1m0s
[12:12:22.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:104:0)
[12:12:22.967] Timer tick, asking Buildbucket for the build status
[12:12:23.109] Build 8856867680849194048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:23.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022297742989222000:105:0) after 1m0s
[12:12:28.696] Received PubSub notification, asking Buildbucket for the build status
[12:12:28.949] Build 8856867680849194048: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:12:28.950] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611835947514702",
"created_by": "project:chromium",
"created_ts": "1611829791173433",
"id": "8856867680849194048",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a1a3ba318c217883f25999867881e9514304edfc\"}}",
"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\": \"a1a3ba318c217883f25999867881e9514304edfc\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-197-j1hi\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22381, \"got_angle_revision\": \"a12edfa5cf68e8aefbe52db0ab7afadfe1c2ac3a\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"a1a3ba318c217883f25999867881e9514304edfc\", \"got_revision_cp\": \"refs/heads/master@{#848053}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"d2db1ff1b7bf9d9adb3ae2c7fada1ed41717de49\", \"got_v8_revision_cp\": \"refs/heads/9.0.93@{#1}\", \"got_webrtc_revision\": \"49dbad021e802197b3c0b966c03b4aa766a5b578\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33080}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"prev_got_revision\": \"3aedad56b236be852c17e5bbb70cc946803c3e2c\", \"prev_got_revision_cp\": \"refs/heads/master@{#848028}\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a1a3ba318c217883f25999867881e9514304edfc\", \"swarm_hashes_refs/heads/master(at){#848053}_without_patch\": {\"absl_hardening_tests\": \"9e2a112f69dccb2a67bcdf19d87c3464fc074fc3\", \"accessibility_unittests\": \"c2f943555beed997347a903fe7f4b035a0f7e000\", \"angle_unittests\": \"9184a4eea7d7c879ee4d7313cba31c3ce0f3a6e2\", \"app_list_unittests\": \"c5c488088631af14e9c2abd0596555e35972850f\", \"app_shell_unittests\": \"23b3f012346ef8463dba70943e6ad40e535ea23b\", \"ash_unittests\": \"dd1aa0b19187fab77b6c42211ebf6b8cdccbd5aa\", \"aura_unittests\": \"77db3ed136c0e04b1a4b1eae3665aa9e2feefd4c\", \"base_unittests\": \"4b6b405b153f682db893b6718ae3ea1804843917\", \"base_util_unittests\": \"563c6ac92d778e04d46acdf4389f4908371da0b1\", \"blink_common_unittests\": \"d847c947e4023a5e314854cb250bc104f32c94b3\", \"blink_fuzzer_unittests\": \"501734be88aa556ef5d8ae54e7faa77505d8af89\", \"blink_heap_unittests\": \"b545b5f14b7a750c58dc1f14cdc2cf9a78265aaa\", \"blink_platform_unittests\": \"7958a15435e61f97e020c72db904ec4c15dd3521\", \"blink_unittests\": \"52da1ebe564daf143e81a349fadeb770e6cc8c0b\", \"boringssl_crypto_tests\": \"b77c975130a0bef618c7ce07824998929a75202d\", \"boringssl_ssl_tests\": \"4226cc5975f99f2a235a3abf08aecf966a04d031\", \"browser_tests\": \"48c62d459fe31dcd5bebea3635b27bdf605f205a\", \"capture_unittests\": \"268b09c88f30c8f7d8d2c6d17026f1dde6bead98\", \"cast_unittests\": \"76a5cbb150f5e0d33068228f92defb664dfa7544\", \"cc_unittests\": \"d2a0c3531be396a856104dd55581518169334c4b\", \"chrome_app_unittests\": \"95b216cfd67938bd3d1057879be167fb11f8f97e\", \"chromedriver_unittests\": \"c919dc2a20b4695a9d1875fcee81a81d4c20c37e\", \"chromeos_components_unittests\": \"c2133fb3ed7ca0d003b856d28914bdbf9b59cae0\", \"chromeos_unittests\": \"682cfb19be11e354fb88bb0824a73c4ddea56d63\", \"components_browsertests\": \"64ca62ed63c5f5735e0b6998dcd8af140348890a\", \"components_unittests\": \"d9e0deeb5b49b35055dc4d2739f984ac8c04ef98\", \"compositor_unittests\": \"f6e9d98854729b4590f9fb71c806c6d91cab4b16\", \"content_browsertests\": \"48eb7c9e4f2ef1ba108668f2da84682aa0e0968c\", \"content_unittests\": \"b678e987540c985c1cb8d02441e3b277cb4604e5\", \"crashpad_tests\": \"3e7b232f2a99ce9b6aa9b650ae342968c1c0328f\", \"crypto_unittests\": \"6778b3e16b7c51c7fb719c691ac6a01793e300b4\", \"dbus_unittests\": \"a0c40f5c365b36b08887746145dcfb09866d4535\", \"device_unittests\": \"92ca723bd306ba62e59618a368bfda1640d3d59b\", \"display_unittests\": \"580eafdaa7ec9408f580f6a539cf0de590dc06f9\", \"events_unittests\": \"3663ea579125e026bcdb8b0d3613477e15c239f2\", \"exo_unittests\": \"dc91efff97571f51354ab7869db44f6f2acb3ccf\", \"extensions_browsertests\": \"c0751f422e39ccf7c7183555def0ba0ca1b11293\", \"extensions_unittests\": \"45bcbe2b454b5445d5fc792033499e79c4f19b1b\", \"filesystem_service_unittests\": \"2a3cd21329e9c98d4b09a267f4c1e19ebbf965ae\", \"gcm_unit_tests\": \"9862c378bfa8a865381fdd2a2beb854da915d16d\", \"gfx_unittests\": \"19faa2981f77cf37c7a48c4a52528c884f70df08\", \"gin_unittests\": \"c8e373e965e32d327cbc6aca45458e07edb0144e\", \"gl_unittests_ozone\": \"c2b8c91d8191ab7252c3bd2c02eb2ae28dc40e79\", \"google_apis_unittests\": \"bbbdf114212fe59901b3f60b662efef26782d978\", \"gpu_unittests\": \"acdde22bc227642de317618051daa06d88050db3\", \"gwp_asan_unittests\": \"3420aaec408c75359c0e60a7202c55a3b1f72009\", \"interactive_ui_tests\": \"fc2d21e0e424d1df2f4a2fca9b80cf5c484b4e83\", \"ipc_tests\": \"8a2f029bf353be77e9101c91f0c4fdc316e90482\", \"jingle_unittests\": \"b74306c21f986a34c800a96a39f49baa28c8c759\", \"keyboard_unittests\": \"ed00fe180fe02f558770ebfaa5eebdb02ec78f3f\", \"latency_unittests\": \"9cee9a41bcc1e52b3b25f54e957838796c4b65c5\", \"libjingle_xmpp_unittests\": \"126bccbba6e25edf3b201eb345973f33bac81e8f\", \"liburlpattern_unittests\": \"682bd9ce67b23f2a52a497f4a851fc25e0e88a2e\", \"media_blink_unittests\": \"64694a3fc0c1871f2ce9e091ec2d69042e45eab5\", \"media_unittests\": \"e3cad36eef4c852de225f2be66bd30b60f187a79\", \"message_center_unittests\": \"ad290bc4dc2d9560dc00df6361709c6fe30d175a\", \"midi_unittests\": \"6231b399bad39925229e66eb25e42bbeb8405206\", \"mojo_core_unittests\": \"451a88076d625b178d9f72781d95c9a60bc4f4ff\", \"mojo_unittests\": \"a2c4e8fca70d5ea4173ec30d04064725908f053a\", \"nacl_helper_nonsfi_unittests\": \"e643a8db00d97ebaaba77d83bd2059287088233f\", \"nacl_loader_unittests\": \"b920d3d6f9c4d205ce7ec6d97feed0bf3fb2762e\", \"native_theme_unittests\": \"b7f762f85dd079dd9be76ae884186e2f9b2e9b5d\", \"net_unittests\": \"01456ce3e06840fbb3f7c5bd25a972a155abc256\", \"ozone_gl_unittests\": \"621d3ee5a4c45de04e066784e003b45ef4f039a9\", \"ozone_unittests\": \"7a6bed5caa3b0db13b8f34ec228c4696a040df65\", \"ozone_x11_unittests\": \"2ca0c7c56073ecc0756ab6019973fc10331ad9f0\", \"pdf_unittests\": \"c4ace4db04c4c56588ae56fe6fe45baa96d9fa09\", \"perfetto_unittests\": \"eeb49feacbfc971f76e72aadc9e48cc07bd9f90e\", \"ppapi_unittests\": \"714cf029c38029a5213404b7d70803c27264c843\", \"printing_unittests\": \"c9bbb440d05712aeabcea8e45748d3c58ae32ee6\", \"remoting_unittests\": \"867a52655db09660dd2a2c1862885c080ff82a50\", \"sandbox_linux_unittests\": \"20e5e705ab827bfcd9222d0e505456321de3036c\", \"service_manager_unittests\": \"bda6dcd16067ef4822a4eefabd54744263a276d3\", \"services_unittests\": \"a1d8b2fc92ccde2cf5bd0680a0e2000f6a9d360d\", \"shell_dialogs_unittests\": \"38ca8823bcfab94c143495408681a1a25109d333\", \"shell_encryption_unittests\": \"db70734566b59f14e05c4ecc29bb6981f3d0575c\", \"skia_unittests\": \"be6be1992f088f1290268152611188ffb8df7641\", \"snapshot_unittests\": \"bf4022658f66062ef345b4c4fcd5837ca7d024ad\", \"sql_unittests\": \"97d61a3b5a0fb7d0d3f2c884cfc6ef9e381359a1\", \"storage_unittests\": \"b51d9b1b63ed02ae7e18db50a0f8bfd40f951985\", \"sync_integration_tests\": \"5f6b8fe2cdc33819ba707313705497b47acceb58\", \"traffic_annotation_auditor_unittests\": \"a2f3dac7e7a1a89cb5f86e0175bc632001919554\", \"ui_base_unittests\": \"6762843814e5e6c5c83edad839f560893812e5a6\", \"ui_chromeos_unittests\": \"57d5fc2e283667a1e412b6e0fe85e293e94a0f8c\", \"ui_touch_selection_unittests\": \"f58ce554c1bda9adc6b26b2bd5005aa10ed62862\", \"unit_tests\": \"2a1e0de69a5b4b9874ff5c806ee897bef286e868\", \"url_unittests\": \"358438b84dabc32cad675e800eef3c84349ba859\", \"usage_time_limit_unittests\": \"5207c5a9a707efe80287bb7601aa3955b9194d58\", \"views_unittests\": \"f5e58b099927359becdb7fbabd0ad09eeef83be0\", \"viz_unittests\": \"6299b44c140654b5e1cb95d4200958f51f694e62\", \"wm_unittests\": \"b07c0bda957bbdf9962c94501c82612d7b9606b3\", \"wtf_unittests\": \"aba9430dd5ec50bdce246f06f36a04946ae3b1f3\", \"zlib_unittests\": \"a9a25e1d4f58421ab889c7d5158efc0bbf96e5be\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02c50c25350278ea3e2feb85c748c248af9e0ccc93852ce717c8651b544f7a96_v2\", \"builder_25c22b29ff9525bbfd333bb12e92a9faf5d35886dc9a7dacce03d872c45df5d1_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_4e62a2152674f2c3254d7105a557302458cce07b755aab1e21dcbd6c7ddeb832_v2\", \"builder_678d8b556ed6d2ea4aa43b80debb7b547a1d6d4433ddff28e80ab170912c760d_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-197-j1hi\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611829793504401",
"status": "COMPLETED",
"status_changed_ts": "1611835947765016",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22381",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a1a3ba318c217883f25999867881e9514304edfc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a1a3ba318c217883f25999867881e9514304edfc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022297742989222000",
"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/8856867680849194048/+/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:51615c5674bfca10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611835947769491",
"url": "https://ci.chromium.org/b/8856867680849194048",
"utcnow_ts": "1611835948935438"
}
}
[12:12:28.950] Invocation finished in 1h42m39.200988062s with status SUCCEEDED