[13:48:30.828] New invocation is queued and will start shortly
[13:48:32.203] Starting the invocation (attempt 1)
[13:48:32.273] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:48:32.273] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:48:32.273] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031254342528445376",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"31b74663d993193db12c991627a4167ab5f9ecca\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9031254342528445376",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/31b74663d993193db12c991627a4167ab5f9ecca",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/31b74663d993193db12c991627a4167ab5f9ecca",
"gitiles_ref:refs/heads/master"
]
}
[13:48:32.986] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603288112402280",
"id": "8865824280207807808",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"31b74663d993193db12c991627a4167ab5f9ecca\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603288112834617",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20949",
"builder:linux-chromeos-dbg",
"buildset:commit/git/31b74663d993193db12c991627a4167ab5f9ecca",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/31b74663d993193db12c991627a4167ab5f9ecca",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031254342528445376",
"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/8865824280207807808/+/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": "1603288112834779",
"url": "https://ci.chromium.org/b/8865824280207807808",
"utcnow_ts": "1603288112968998"
}
}
[13:48:32.986] Task URL: https://ci.chromium.org/b/8865824280207807808
[13:48:32.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:2:0) after 1m0s
[13:48:36.832] Received PubSub notification, asking Buildbucket for the build status
[13:48:37.037] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:33.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:2:0)
[13:49:33.142] Timer tick, asking Buildbucket for the build status
[13:49:33.340] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:33.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:4:0) after 1m0s
[13:50:33.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:4:0)
[13:50:33.532] Timer tick, asking Buildbucket for the build status
[13:50:33.601] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:33.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:5:0) after 1m0s
[13:51:33.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:5:0)
[13:51:33.687] Timer tick, asking Buildbucket for the build status
[13:51:34.083] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:34.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:6:0) after 1m0s
[13:52:34.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:6:0)
[13:52:34.294] Timer tick, asking Buildbucket for the build status
[13:52:34.479] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:34.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:7:0) after 1m0s
[13:53:34.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:7:0)
[13:53:34.672] Timer tick, asking Buildbucket for the build status
[13:53:34.792] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:34.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:8:0) after 1m0s
[13:54:34.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:8:0)
[13:54:34.976] Timer tick, asking Buildbucket for the build status
[13:54:35.089] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:35.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:9:0) after 1m0s
[13:55:35.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:9:0)
[13:55:35.251] Timer tick, asking Buildbucket for the build status
[13:55:35.351] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:35.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:10:0) after 1m0s
[13:56:35.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:10:0)
[13:56:35.457] Timer tick, asking Buildbucket for the build status
[13:56:37.741] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:37.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:11:0) after 1m0s
[13:57:37.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:11:0)
[13:57:37.756] Timer tick, asking Buildbucket for the build status
[13:57:39.085] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:39.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:12:0) after 1m0s
[13:58:39.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:12:0)
[13:58:39.178] Timer tick, asking Buildbucket for the build status
[13:58:39.496] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:39.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:13:0) after 1m0s
[13:59:39.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:13:0)
[13:59:39.552] Timer tick, asking Buildbucket for the build status
[13:59:39.653] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:39.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:14:0) after 1m0s
[14:00:39.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:14:0)
[14:00:39.691] Timer tick, asking Buildbucket for the build status
[14:00:39.768] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:39.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:15:0) after 1m0s
[14:01:39.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:15:0)
[14:01:39.925] Timer tick, asking Buildbucket for the build status
[14:01:40.108] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:40.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:16:0) after 1m0s
[14:02:40.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:16:0)
[14:02:40.141] Timer tick, asking Buildbucket for the build status
[14:02:40.529] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:40.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:17:0) after 1m0s
[14:03:40.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:17:0)
[14:03:40.563] Timer tick, asking Buildbucket for the build status
[14:03:40.738] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:40.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:18:0) after 1m0s
[14:04:40.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:18:0)
[14:04:40.856] Timer tick, asking Buildbucket for the build status
[14:04:40.935] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:40.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:19:0) after 1m0s
[14:05:41.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:19:0)
[14:05:41.034] Timer tick, asking Buildbucket for the build status
[14:05:41.137] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:41.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:20:0) after 1m0s
[14:06:41.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:20:0)
[14:06:41.289] Timer tick, asking Buildbucket for the build status
[14:06:41.597] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:41.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:21:0) after 1m0s
[14:07:41.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:21:0)
[14:07:41.696] Timer tick, asking Buildbucket for the build status
[14:07:41.758] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:41.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:22:0) after 1m0s
[14:08:41.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:22:0)
[14:08:41.852] Timer tick, asking Buildbucket for the build status
[14:08:42.042] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:42.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:23:0) after 1m0s
[14:09:42.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:23:0)
[14:09:42.137] Timer tick, asking Buildbucket for the build status
[14:09:42.208] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:42.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:24:0) after 1m0s
[14:10:42.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:24:0)
[14:10:42.281] Timer tick, asking Buildbucket for the build status
[14:10:42.360] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:42.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:25:0) after 1m0s
[14:11:42.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:25:0)
[14:11:42.487] Timer tick, asking Buildbucket for the build status
[14:11:42.577] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:42.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:26:0) after 1m0s
[14:12:42.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:26:0)
[14:12:42.637] Timer tick, asking Buildbucket for the build status
[14:12:42.711] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:42.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:27:0) after 1m0s
[14:13:42.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:27:0)
[14:13:42.786] Timer tick, asking Buildbucket for the build status
[14:13:43.028] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:43.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:28:0) after 1m0s
[14:14:43.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:28:0)
[14:14:43.077] Timer tick, asking Buildbucket for the build status
[14:14:43.330] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:43.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:29:0) after 1m0s
[14:15:43.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:29:0)
[14:15:43.433] Timer tick, asking Buildbucket for the build status
[14:15:43.499] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:43.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:30:0) after 1m0s
[14:16:43.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:30:0)
[14:16:43.592] Timer tick, asking Buildbucket for the build status
[14:16:43.720] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:43.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:31:0) after 1m0s
[14:17:43.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:31:0)
[14:17:43.769] Timer tick, asking Buildbucket for the build status
[14:17:43.839] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:43.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:32:0) after 1m0s
[14:18:43.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:32:0)
[14:18:43.868] Timer tick, asking Buildbucket for the build status
[14:18:44.016] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:44.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:33:0) after 1m0s
[14:19:44.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:33:0)
[14:19:44.046] Timer tick, asking Buildbucket for the build status
[14:19:44.249] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:44.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:34:0) after 1m0s
[14:20:44.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:34:0)
[14:20:44.420] Timer tick, asking Buildbucket for the build status
[14:20:44.496] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:44.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:35:0) after 1m0s
[14:21:44.541] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:35:0)
[14:21:44.541] Timer tick, asking Buildbucket for the build status
[14:21:44.595] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:44.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:36:0) after 1m0s
[14:22:44.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:36:0)
[14:22:44.655] Timer tick, asking Buildbucket for the build status
[14:22:44.738] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:44.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:37:0) after 1m0s
[14:23:44.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:37:0)
[14:23:44.762] Timer tick, asking Buildbucket for the build status
[14:23:44.938] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:44.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:38:0) after 1m0s
[14:24:44.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:38:0)
[14:24:44.970] Timer tick, asking Buildbucket for the build status
[14:24:45.295] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:45.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:39:0) after 1m0s
[14:25:45.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:39:0)
[14:25:45.314] Timer tick, asking Buildbucket for the build status
[14:25:45.374] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:45.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:40:0) after 1m0s
[14:26:45.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:40:0)
[14:26:45.399] Timer tick, asking Buildbucket for the build status
[14:26:45.463] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:45.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:41:0) after 1m0s
[14:27:45.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:41:0)
[14:27:45.508] Timer tick, asking Buildbucket for the build status
[14:27:45.648] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:45.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:42:0) after 1m0s
[14:28:46.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:42:0)
[14:28:46.073] Timer tick, asking Buildbucket for the build status
[14:28:46.233] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:46.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:43:0) after 1m0s
[14:29:46.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:43:0)
[14:29:46.343] Timer tick, asking Buildbucket for the build status
[14:29:46.705] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:46.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:44:0) after 1m0s
[14:30:46.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:44:0)
[14:30:46.768] Timer tick, asking Buildbucket for the build status
[14:30:46.929] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:46.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:45:0) after 1m0s
[14:31:47.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:45:0)
[14:31:47.048] Timer tick, asking Buildbucket for the build status
[14:31:47.228] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:47.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:46:0) after 1m0s
[14:32:47.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:46:0)
[14:32:47.253] Timer tick, asking Buildbucket for the build status
[14:32:47.323] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:47.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:47:0) after 1m0s
[14:33:47.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:47:0)
[14:33:47.527] Timer tick, asking Buildbucket for the build status
[14:33:47.642] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:47.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:48:0) after 1m0s
[14:34:47.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:48:0)
[14:34:47.666] Timer tick, asking Buildbucket for the build status
[14:34:47.765] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:47.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:49:0) after 1m0s
[14:35:47.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:49:0)
[14:35:47.756] Timer tick, asking Buildbucket for the build status
[14:35:47.927] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:47.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:50:0) after 1m0s
[14:36:48.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:50:0)
[14:36:48.085] Timer tick, asking Buildbucket for the build status
[14:36:48.145] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:48.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:51:0) after 1m0s
[14:37:48.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:51:0)
[14:37:48.346] Timer tick, asking Buildbucket for the build status
[14:37:48.603] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:48.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:52:0) after 1m0s
[14:38:48.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:52:0)
[14:38:48.720] Timer tick, asking Buildbucket for the build status
[14:38:48.864] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:48.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:53:0) after 1m0s
[14:39:48.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:53:0)
[14:39:48.937] Timer tick, asking Buildbucket for the build status
[14:39:49.061] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:49.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:54:0) after 1m0s
[14:40:49.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:54:0)
[14:40:49.207] Timer tick, asking Buildbucket for the build status
[14:40:49.356] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:49.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:55:0) after 1m0s
[14:41:49.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:55:0)
[14:41:49.512] Timer tick, asking Buildbucket for the build status
[14:41:49.735] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:49.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:56:0) after 1m0s
[14:42:49.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:56:0)
[14:42:49.781] Timer tick, asking Buildbucket for the build status
[14:42:49.962] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:49.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:57:0) after 1m0s
[14:43:50.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:57:0)
[14:43:50.058] Timer tick, asking Buildbucket for the build status
[14:43:50.172] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:50.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:58:0) after 1m0s
[14:44:50.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:58:0)
[14:44:50.261] Timer tick, asking Buildbucket for the build status
[14:44:50.424] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:50.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:59:0) after 1m0s
[14:45:50.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:59:0)
[14:45:50.471] Timer tick, asking Buildbucket for the build status
[14:45:50.619] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:50.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:60:0) after 1m0s
[14:46:50.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:60:0)
[14:46:50.710] Timer tick, asking Buildbucket for the build status
[14:46:50.846] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:50.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:61:0) after 1m0s
[14:47:50.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:61:0)
[14:47:50.899] Timer tick, asking Buildbucket for the build status
[14:47:51.029] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:51.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:62:0) after 1m0s
[14:48:51.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:62:0)
[14:48:51.667] Timer tick, asking Buildbucket for the build status
[14:48:51.876] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:51.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:63:0) after 1m0s
[14:49:51.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:63:0)
[14:49:51.925] Timer tick, asking Buildbucket for the build status
[14:49:52.063] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:52.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:64:0) after 1m0s
[14:50:52.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:64:0)
[14:50:52.082] Timer tick, asking Buildbucket for the build status
[14:50:52.394] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:52.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:65:0) after 1m0s
[14:51:52.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:65:0)
[14:51:52.477] Timer tick, asking Buildbucket for the build status
[14:51:52.562] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:52.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:66:0) after 1m0s
[14:52:52.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:66:0)
[14:52:52.579] Timer tick, asking Buildbucket for the build status
[14:52:52.881] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:52.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:67:0) after 1m0s
[14:53:52.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:67:0)
[14:53:52.905] Timer tick, asking Buildbucket for the build status
[14:53:53.081] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:53.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:68:0) after 1m0s
[14:54:53.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:68:0)
[14:54:53.142] Timer tick, asking Buildbucket for the build status
[14:54:53.517] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:53.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:69:0) after 1m0s
[14:55:53.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:69:0)
[14:55:53.613] Timer tick, asking Buildbucket for the build status
[14:55:53.731] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:53.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:70:0) after 1m0s
[14:56:53.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:70:0)
[14:56:53.829] Timer tick, asking Buildbucket for the build status
[14:56:53.984] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:53.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:71:0) after 1m0s
[14:57:53.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:71:0)
[14:57:53.989] Timer tick, asking Buildbucket for the build status
[14:57:54.611] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:54.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:72:0) after 1m0s
[14:58:54.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:72:0)
[14:58:54.688] Timer tick, asking Buildbucket for the build status
[14:58:55.133] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:55.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:73:0) after 1m0s
[14:59:55.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:73:0)
[14:59:55.152] Timer tick, asking Buildbucket for the build status
[14:59:55.495] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:55.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:74:0) after 1m0s
[15:00:55.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:74:0)
[15:00:55.519] Timer tick, asking Buildbucket for the build status
[15:00:56.045] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:56.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:75:0) after 1m0s
[15:01:56.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:75:0)
[15:01:56.090] Timer tick, asking Buildbucket for the build status
[15:01:56.320] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:56.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:76:0) after 1m0s
[15:02:56.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:76:0)
[15:02:56.355] Timer tick, asking Buildbucket for the build status
[15:02:56.480] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:56.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:77:0) after 1m0s
[15:03:56.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:77:0)
[15:03:56.537] Timer tick, asking Buildbucket for the build status
[15:03:56.676] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:56.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:78:0) after 1m0s
[15:04:56.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:78:0)
[15:04:56.729] Timer tick, asking Buildbucket for the build status
[15:04:56.933] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:56.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:79:0) after 1m0s
[15:05:56.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:79:0)
[15:05:56.950] Timer tick, asking Buildbucket for the build status
[15:05:57.022] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:57.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:80:0) after 1m0s
[15:06:57.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:80:0)
[15:06:57.035] Timer tick, asking Buildbucket for the build status
[15:06:57.204] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:57.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:81:0) after 1m0s
[15:07:57.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:81:0)
[15:07:57.230] Timer tick, asking Buildbucket for the build status
[15:07:57.302] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:57.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:82:0) after 1m0s
[15:08:57.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:82:0)
[15:08:57.286] Timer tick, asking Buildbucket for the build status
[15:08:57.490] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:57.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:83:0) after 1m0s
[15:09:57.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:83:0)
[15:09:57.491] Timer tick, asking Buildbucket for the build status
[15:09:59.395] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:59.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:84:0) after 1m0s
[15:10:59.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:84:0)
[15:10:59.420] Timer tick, asking Buildbucket for the build status
[15:10:59.535] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:59.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:85:0) after 1m0s
[15:11:59.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:85:0)
[15:11:59.619] Timer tick, asking Buildbucket for the build status
[15:12:00.271] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:00.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:86:0) after 1m0s
[15:13:00.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:86:0)
[15:13:00.305] Timer tick, asking Buildbucket for the build status
[15:13:00.503] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:00.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:87:0) after 1m0s
[15:14:00.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:87:0)
[15:14:00.554] Timer tick, asking Buildbucket for the build status
[15:14:00.695] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:00.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:88:0) after 1m0s
[15:15:01.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:88:0)
[15:15:01.179] Timer tick, asking Buildbucket for the build status
[15:15:01.795] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:01.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:89:0) after 1m0s
[15:16:02.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:89:0)
[15:16:02.809] Timer tick, asking Buildbucket for the build status
[15:16:02.912] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:02.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:90:0) after 1m0s
[15:17:02.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:90:0)
[15:17:02.968] Timer tick, asking Buildbucket for the build status
[15:17:03.089] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:03.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:91:0) after 1m0s
[15:18:03.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:91:0)
[15:18:03.111] Timer tick, asking Buildbucket for the build status
[15:18:03.317] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:03.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:92:0) after 1m0s
[15:19:03.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:92:0)
[15:19:03.309] Timer tick, asking Buildbucket for the build status
[15:19:05.580] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:05.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:93:0) after 1m0s
[15:20:05.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:93:0)
[15:20:05.625] Timer tick, asking Buildbucket for the build status
[15:20:05.701] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:05.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:94:0) after 1m0s
[15:21:05.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:94:0)
[15:21:05.725] Timer tick, asking Buildbucket for the build status
[15:21:05.816] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:05.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:95:0) after 1m0s
[15:22:05.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:95:0)
[15:22:05.841] Timer tick, asking Buildbucket for the build status
[15:22:05.969] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:05.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:96:0) after 1m0s
[15:23:05.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:96:0)
[15:23:05.963] Timer tick, asking Buildbucket for the build status
[15:23:06.052] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:06.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:97:0) after 1m0s
[15:24:06.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:97:0)
[15:24:06.057] Timer tick, asking Buildbucket for the build status
[15:24:06.259] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:06.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:98:0) after 1m0s
[15:25:06.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:98:0)
[15:25:06.286] Timer tick, asking Buildbucket for the build status
[15:25:06.362] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:06.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:99:0) after 1m0s
[15:26:06.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:99:0)
[15:26:06.482] Timer tick, asking Buildbucket for the build status
[15:26:06.722] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:06.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:100:0) after 1m0s
[15:27:06.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:100:0)
[15:27:06.771] Timer tick, asking Buildbucket for the build status
[15:27:07.272] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:07.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:101:0) after 1m0s
[15:28:07.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:101:0)
[15:28:07.307] Timer tick, asking Buildbucket for the build status
[15:28:07.810] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:07.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:102:0) after 1m0s
[15:29:07.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:102:0)
[15:29:07.843] Timer tick, asking Buildbucket for the build status
[15:29:07.960] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:07.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:103:0) after 1m0s
[15:30:07.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:103:0)
[15:30:07.995] Timer tick, asking Buildbucket for the build status
[15:30:08.396] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:08.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:104:0) after 1m0s
[15:31:08.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:104:0)
[15:31:08.472] Timer tick, asking Buildbucket for the build status
[15:31:08.542] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:08.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:105:0) after 1m0s
[15:32:08.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:105:0)
[15:32:08.519] Timer tick, asking Buildbucket for the build status
[15:32:08.594] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:08.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:106:0) after 1m0s
[15:33:08.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:106:0)
[15:33:08.605] Timer tick, asking Buildbucket for the build status
[15:33:08.714] Build 8865824280207807808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:08.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031254342528445376:107:0) after 1m0s
[15:33:38.922] Received PubSub notification, asking Buildbucket for the build status
[15:33:39.073] Build 8865824280207807808: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:33:39.073] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603294417892790",
"created_by": "project:chromium",
"created_ts": "1603288112402280",
"id": "8865824280207807808",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"31b74663d993193db12c991627a4167ab5f9ecca\"}}",
"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\": \"31b74663d993193db12c991627a4167ab5f9ecca\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-46-1ou6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 20949, \"got_angle_revision\": \"553726a4c5c88ab2cc0cf75323aaa3ccd6cd4c60\", \"got_dawn_revision\": \"e2cbcc9565886e0a066580e3be7426b9924be72f\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"31b74663d993193db12c991627a4167ab5f9ecca\", \"got_revision_cp\": \"refs/heads/master@{#819354}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"84f5eeb6dd9b225f465f93737fa76aad7de355cf\", \"got_v8_revision\": \"d82ff002381657c44563e830ec337d103b99d565\", \"got_v8_revision_cp\": \"refs/heads/8.8.148@{#1}\", \"got_webrtc_revision\": \"7bc3356fbcb9b95ea2c810ae2f3152930d54577b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32449}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"31b74663d993193db12c991627a4167ab5f9ecca\", \"swarm_hashes_refs/heads/master(at){#819354}_without_patch\": {\"absl_hardening_tests\": \"5aa09cd73c06eab892a9a6f976bdefbf3c392f6b\", \"accessibility_unittests\": \"1caaadc31232e56d4fcdae43a4f3b13e5b2b59bf\", \"app_list_unittests\": \"8181e2196f08f3831973fb925dda0f3150b30581\", \"app_shell_unittests\": \"78b4e39f56800001160c88194cde67f16c70ba6e\", \"ash_unittests\": \"28379ca7f9e327da863b1512fadeb2b5a45e74bb\", \"aura_unittests\": \"fd1912e2880719a3a89f58e0746515b54318a682\", \"base_unittests\": \"5ccdf9d1cf566e1bbd9d08831eb4b4516894e20e\", \"base_util_unittests\": \"98462ef37492649b57e927e61dc280c024bc032c\", \"blink_common_unittests\": \"c9addf19863e1d8ad6b582eefec62a145806020b\", \"blink_fuzzer_unittests\": \"67e40cc6d0ae0ea2f5500f07ae6fc4be0d1d5e1c\", \"blink_heap_unittests\": \"ee075fab06c3470bcf29664f71a7ec1439a20071\", \"blink_platform_unittests\": \"d7753bd17ccbe59abc70bc721e9324a712c41647\", \"blink_unittests\": \"407f7d4200e14b547ddb96f4bc49db81f2a0bb2d\", \"boringssl_crypto_tests\": \"da7adc3950f1eb5b3846e784491dbd8da6ed4553\", \"boringssl_ssl_tests\": \"8cfd9441b606cb220f6b20fb3128e3ca87a21dfe\", \"browser_tests\": \"4af3a68848220f7165542a29dd0eb57d67bc01b4\", \"capture_unittests\": \"016d10fb7a1cc1a95c7134e8c9059787860d9822\", \"cast_unittests\": \"7e93031b81ad9468f3a160f47acd0d0125faba0f\", \"cc_unittests\": \"7e6f1cfb8d873d11594edde2118666162670b6ef\", \"chrome_app_unittests\": \"f50844c4dfc3a5cedc403498c79becef8adb5892\", \"chromedriver_unittests\": \"92ef1f4444b641ef97af1f7cf1442affd1140265\", \"chromeos_components_unittests\": \"55e4b96128ad4b222fcf6299ef8079a00d3829b3\", \"chromeos_unittests\": \"49f150631ca86f15df5fb99de0674e34ca31b0b2\", \"components_browsertests\": \"cd2bce7d40af07c7ecd4c20c360241bf1c421c60\", \"components_unittests\": \"9aa4df3411d965a77e43e9e02852d0dc8a08aa0a\", \"compositor_unittests\": \"7ac2ba9c4b2a2d497afbbfa1170b4e1db7c20ac9\", \"content_browsertests\": \"e35009f3ab24f29e28f129c186870b0f7658de17\", \"content_unittests\": \"f0c857c53ffe130982891b5cc9311ff4266a9ab0\", \"crypto_unittests\": \"c9ac237032a45366c27ca0892d50210e5db3d3d5\", \"dbus_unittests\": \"33b81e86e641beab1c1e62d0e0bb0419af64dc41\", \"device_unittests\": \"9bd576a1727f77d1d9ab4f9c570f6bcebf2de549\", \"display_unittests\": \"009a283d294f4fcd5ea09327acee25d0eaad1fb0\", \"events_unittests\": \"a834e90f782e291d4742bfb5c8058256e9767767\", \"exo_unittests\": \"2dd0e92f20c91724692e51a446c6aa218560dedf\", \"extensions_browsertests\": \"2fdd20f98f0ea780655a5dfe9f764d0926f4d412\", \"extensions_unittests\": \"9df193d4f917b1e5ce400b5c4414ac60906e764a\", \"filesystem_service_unittests\": \"e0235a36351cd7a86ec50307b4070485102b2a9a\", \"gcm_unit_tests\": \"de88391086e47169649d1f107ead9a0cf212b993\", \"gfx_unittests\": \"d04375a6cb1aafceef0f9115f6cc12342d3035cd\", \"gin_unittests\": \"82d6ab97b9874ce55f3c6e369edd61411e345510\", \"gl_unittests_ozone\": \"bfb7058b4a9ad7a9b6bcbf6fede2e9aa91911348\", \"google_apis_unittests\": \"14658202da514e9ce74c40c102fa4c9308ebc505\", \"gpu_unittests\": \"97feeb4e028aa07b67b4d26b20b00a511b8b68d8\", \"gwp_asan_unittests\": \"ec5e9b7018200cbe8154a8cf59778512dec2ed88\", \"interactive_ui_tests\": \"3c25884ef5a20fc6393d228947b119d2960972eb\", \"ipc_tests\": \"604c444490e2ceddc6a99d20158a423e5d0b2165\", \"jingle_unittests\": \"f79ae56b363c89b4820fee19c7dc8113b56a9133\", \"keyboard_unittests\": \"4b44bd919b4cb071c975ddbfd3370126484390c5\", \"latency_unittests\": \"9f4853d85b064c9c30306556e49d580f08e55f45\", \"libjingle_xmpp_unittests\": \"5f31e2c8f75fe3e85a815e1ae74049f5ab8f0cf9\", \"media_blink_unittests\": \"99f80485801648db3e4cd6d5537adad6527bede1\", \"media_unittests\": \"671e22f8cc340b112eff12204539bf18ede2843f\", \"message_center_unittests\": \"3df31ca6890a55d8b4fc6668cc3f98735397e4c1\", \"midi_unittests\": \"38130f94b9567897fbb554ddb52844f819abe012\", \"mojo_core_unittests\": \"fbd749005b590dcd19f0edc45f3aee824ef7bdd1\", \"mojo_unittests\": \"ba52937fc40e631b28e5f4b1cc84b7f56e12b759\", \"nacl_helper_nonsfi_unittests\": \"9ddbac710c15ae303846e0f91accf4606fc021ea\", \"nacl_loader_unittests\": \"399788e1de25d87f340cc949cbff610fdad42024\", \"native_theme_unittests\": \"e0304005825a060223d7c1a9e8faa2cbf26e9f2e\", \"net_unittests\": \"eb4a929c69046a4b5a7818a1a6b6220f9e325bc4\", \"ozone_gl_unittests\": \"4e0830d32d335f587532154bffa07f806e2d7445\", \"ozone_unittests\": \"88909efbd99a1e0fecf5d3d706297b5895035482\", \"ozone_x11_unittests\": \"d6dd2d1621d09bd9cda30cc14bbd13d49e34185d\", \"pdf_unittests\": \"74d1b930b25b17e33edccd31cb0e8936fe9fcb9a\", \"perfetto_unittests\": \"490dc1f19183dd41e2c67ee5d7ebbd142e473aaa\", \"ppapi_unittests\": \"bc7f641a63080949b97bddeca29a7dc1a6bc2bc1\", \"printing_unittests\": \"01f04ae45fe4fed88486fe77f19e60b7dd8f3bbd\", \"remoting_unittests\": \"cfe4608fbedbb5c1fc853cba4ee445589807dc4b\", \"sandbox_linux_unittests\": \"01636280f3c69d52c0726930903ed39723955fb9\", \"service_manager_unittests\": \"b2989e0d572544201940aecebe319c831c55b696\", \"services_unittests\": \"b4d48bb0daf2efb006875689803eac7a20e73b14\", \"shell_dialogs_unittests\": \"1e6f64c4e11789981d750e4a6d29f58f3b2dbc3c\", \"skia_unittests\": \"cd7025806554435725587be510f7f05d0c010f03\", \"snapshot_unittests\": \"0cb44dfed5222dfc2408b766a4cb1e3e7fbd58b6\", \"sql_unittests\": \"2359cff61281c5dc76d7e727d7a9f510530faa2f\", \"standalone_angle_unittests\": \"3c5e17a644bcfacad7c696683909892994aa9ef3\", \"storage_unittests\": \"60b88d443517237054a09d1f4549d87e38f11a1f\", \"sync_integration_tests\": \"3bde0d5b014243611b594e091307e950751d2dd5\", \"traffic_annotation_auditor_unittests\": \"0732ac50929c34df9a929c3b1b8d91f2560e68a7\", \"ui_base_unittests\": \"d8591b004d3a3ce8ef0cd63b601c3c7c7e2f3aed\", \"ui_chromeos_unittests\": \"471077911bdbc4e9d11d05a6b18d8027d63539fe\", \"ui_touch_selection_unittests\": \"eabc8adc207b25e47f95a3da1901c10364375865\", \"unit_tests\": \"80934c383bb3eb8e36788a106e896383298ca07b\", \"url_unittests\": \"e207e44e3a4afb14e3c8d658ef85f148e56a8adf\", \"usage_time_limit_unittests\": \"a84091fb7029d9b7d089a26de6ca1ff7f3db67ea\", \"views_unittests\": \"79372458154f9c9853378ff8b27cb8256402dfd2\", \"viz_unittests\": \"8dca3209f6cc3dab16b56c08bbb7392834e52348\", \"wm_unittests\": \"12b75a6b1bd79c031c694d4a1c301b473b7cb9fe\", \"wtf_unittests\": \"b6bc214f1d8ada924c05dcdf7f792a0e627d8ec4\", \"zlib_unittests\": \"fcc0bc6baecbfb5ddc3b103e1d810e8d6f370d69\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_62ff673344f63b1d0862893f2031420df362e89a2b43f8f65e2ede9a934c5b6f_v2\", \"builder_a432d290b72bc0f3cae401fbd647c33c14340f64e89770e9c9c39d6230495526_v2\", \"builder_b5e41ce0b01ce81870a1097ddb1343f2a3924630f4d3bb9f1a0eaa4d6a5abbed_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-46-1ou6\"], \"image\": [\"chrome-xenial-20101400-bb93c5ec2c2\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5601-97d7e7d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603288115776959",
"status": "COMPLETED",
"status_changed_ts": "1603294418326122",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20949",
"builder:linux-chromeos-dbg",
"buildset:commit/git/31b74663d993193db12c991627a4167ab5f9ecca",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/31b74663d993193db12c991627a4167ab5f9ecca",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031254342528445376",
"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/8865824280207807808/+/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:4f643ca8bca51210",
"user_agent:luci-scheduler"
],
"updated_ts": "1603294418331467",
"url": "https://ci.chromium.org/b/8865824280207807808",
"utcnow_ts": "1603294419063756"
}
}
[15:33:39.073] Invocation finished in 1h45m8.267908736s with status SUCCEEDED