[16:40:02.531] New invocation is queued and will start shortly
[16:40:04.339] Starting the invocation (attempt 1)
[16:40:04.417] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:40:04.417] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:40:04.417] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027619672243452816",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d22d425e1f0b31a635b2706121a16dcfe0c9388b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9027619672243452816",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/d22d425e1f0b31a635b2706121a16dcfe0c9388b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d22d425e1f0b31a635b2706121a16dcfe0c9388b",
"gitiles_ref:refs/heads/master"
]
}
[16:40:06.762] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606754404614684",
"id": "8862189609385616672",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d22d425e1f0b31a635b2706121a16dcfe0c9388b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606754405420915",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21543",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d22d425e1f0b31a635b2706121a16dcfe0c9388b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d22d425e1f0b31a635b2706121a16dcfe0c9388b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027619672243452816",
"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/8862189609385616672/+/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": "1606754405421141",
"url": "https://ci.chromium.org/b/8862189609385616672",
"utcnow_ts": "1606754405714858"
}
}
[16:40:06.762] Task URL: https://ci.chromium.org/b/8862189609385616672
[16:40:06.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:2:0) after 1m0s
[16:40:09.129] Received PubSub notification, asking Buildbucket for the build status
[16:40:09.228] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:06.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:2:0)
[16:41:06.810] Timer tick, asking Buildbucket for the build status
[16:41:08.504] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:08.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:4:0) after 1m0s
[16:42:08.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:4:0)
[16:42:08.613] Timer tick, asking Buildbucket for the build status
[16:42:08.690] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:08.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:5:0) after 1m0s
[16:43:08.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:5:0)
[16:43:08.848] Timer tick, asking Buildbucket for the build status
[16:43:09.314] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:09.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:6:0) after 1m0s
[16:44:09.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:6:0)
[16:44:09.391] Timer tick, asking Buildbucket for the build status
[16:44:09.612] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:09.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:7:0) after 1m0s
[16:45:09.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:7:0)
[16:45:09.661] Timer tick, asking Buildbucket for the build status
[16:45:10.511] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:10.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:8:0) after 1m0s
[16:46:10.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:8:0)
[16:46:10.564] Timer tick, asking Buildbucket for the build status
[16:46:10.869] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:10.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:9:0) after 1m0s
[16:47:10.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:9:0)
[16:47:10.977] Timer tick, asking Buildbucket for the build status
[16:47:11.051] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:11.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:10:0) after 1m0s
[16:48:11.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:10:0)
[16:48:11.147] Timer tick, asking Buildbucket for the build status
[16:48:11.215] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:11.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:11:0) after 1m0s
[16:49:11.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:11:0)
[16:49:11.320] Timer tick, asking Buildbucket for the build status
[16:49:12.345] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:12.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:12:0) after 1m0s
[16:50:12.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:12:0)
[16:50:12.357] Timer tick, asking Buildbucket for the build status
[16:50:12.518] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:12.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:13:0) after 1m0s
[16:51:12.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:13:0)
[16:51:12.506] Timer tick, asking Buildbucket for the build status
[16:51:12.622] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:12.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:14:0) after 1m0s
[16:52:12.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:14:0)
[16:52:12.715] Timer tick, asking Buildbucket for the build status
[16:52:12.789] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:12.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:15:0) after 1m0s
[16:53:12.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:15:0)
[16:53:12.825] Timer tick, asking Buildbucket for the build status
[16:53:12.946] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:12.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:16:0) after 1m0s
[16:54:13.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:16:0)
[16:54:13.006] Timer tick, asking Buildbucket for the build status
[16:54:13.533] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:13.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:17:0) after 1m0s
[16:55:13.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:17:0)
[16:55:13.741] Timer tick, asking Buildbucket for the build status
[16:55:14.028] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:14.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:18:0) after 1m0s
[16:56:14.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:18:0)
[16:56:14.115] Timer tick, asking Buildbucket for the build status
[16:56:14.259] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:14.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:19:0) after 1m0s
[16:57:14.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:19:0)
[16:57:14.283] Timer tick, asking Buildbucket for the build status
[16:57:14.550] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:14.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:20:0) after 1m0s
[16:58:14.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:20:0)
[16:58:14.570] Timer tick, asking Buildbucket for the build status
[16:58:14.708] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:14.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:21:0) after 1m0s
[16:59:14.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:21:0)
[16:59:14.809] Timer tick, asking Buildbucket for the build status
[16:59:15.815] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:15.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:22:0) after 1m0s
[17:00:15.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:22:0)
[17:00:15.956] Timer tick, asking Buildbucket for the build status
[17:00:16.443] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:16.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:23:0) after 1m0s
[17:01:16.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:23:0)
[17:01:16.517] Timer tick, asking Buildbucket for the build status
[17:01:16.802] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:16.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:24:0) after 1m0s
[17:02:16.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:24:0)
[17:02:16.880] Timer tick, asking Buildbucket for the build status
[17:02:17.730] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:17.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:25:0) after 1m0s
[17:03:17.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:25:0)
[17:03:17.791] Timer tick, asking Buildbucket for the build status
[17:03:17.910] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:17.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:26:0) after 1m0s
[17:04:17.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:26:0)
[17:04:17.924] Timer tick, asking Buildbucket for the build status
[17:04:18.436] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:18.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:27:0) after 1m0s
[17:05:18.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:27:0)
[17:05:18.473] Timer tick, asking Buildbucket for the build status
[17:05:18.874] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:18.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:28:0) after 1m0s
[17:06:18.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:28:0)
[17:06:18.982] Timer tick, asking Buildbucket for the build status
[17:06:20.095] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:20.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:29:0) after 1m0s
[17:07:20.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:29:0)
[17:07:20.235] Timer tick, asking Buildbucket for the build status
[17:07:21.408] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:21.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:30:0) after 1m0s
[17:08:21.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:30:0)
[17:08:21.696] Timer tick, asking Buildbucket for the build status
[17:08:22.260] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:22.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:31:0) after 1m0s
[17:09:22.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:31:0)
[17:09:22.298] Timer tick, asking Buildbucket for the build status
[17:09:22.425] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:22.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:32:0) after 1m0s
[17:10:22.541] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:32:0)
[17:10:22.541] Timer tick, asking Buildbucket for the build status
[17:10:23.089] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:23.090] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:33:0) after 1m0s
[17:11:23.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:33:0)
[17:11:23.246] Timer tick, asking Buildbucket for the build status
[17:11:23.317] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:23.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:34:0) after 1m0s
[17:12:23.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:34:0)
[17:12:23.412] Timer tick, asking Buildbucket for the build status
[17:12:24.010] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:24.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:35:0) after 1m0s
[17:13:24.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:35:0)
[17:13:24.153] Timer tick, asking Buildbucket for the build status
[17:13:24.217] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:24.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:36:0) after 1m0s
[17:14:24.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:36:0)
[17:14:24.331] Timer tick, asking Buildbucket for the build status
[17:14:24.619] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:24.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:37:0) after 1m0s
[17:15:24.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:37:0)
[17:15:24.764] Timer tick, asking Buildbucket for the build status
[17:15:24.944] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:24.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:38:0) after 1m0s
[17:16:25.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:38:0)
[17:16:25.308] Timer tick, asking Buildbucket for the build status
[17:16:25.448] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:25.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:39:0) after 1m0s
[17:17:25.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:39:0)
[17:17:25.503] Timer tick, asking Buildbucket for the build status
[17:17:25.650] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:25.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:40:0) after 1m0s
[17:18:25.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:40:0)
[17:18:25.854] Timer tick, asking Buildbucket for the build status
[17:18:26.120] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:26.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:41:0) after 1m0s
[17:19:26.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:41:0)
[17:19:26.208] Timer tick, asking Buildbucket for the build status
[17:19:26.396] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:26.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:42:0) after 1m0s
[17:20:26.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:42:0)
[17:20:26.514] Timer tick, asking Buildbucket for the build status
[17:20:26.650] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:26.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:43:0) after 1m0s
[17:21:26.817] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:43:0)
[17:21:26.817] Timer tick, asking Buildbucket for the build status
[17:21:27.247] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:27.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:44:0) after 1m0s
[17:22:27.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:44:0)
[17:22:27.368] Timer tick, asking Buildbucket for the build status
[17:22:27.465] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:27.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:45:0) after 1m0s
[17:23:27.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:45:0)
[17:23:27.615] Timer tick, asking Buildbucket for the build status
[17:23:27.754] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:27.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:46:0) after 1m0s
[17:24:27.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:46:0)
[17:24:27.839] Timer tick, asking Buildbucket for the build status
[17:24:27.940] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:27.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:47:0) after 1m0s
[17:25:28.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:47:0)
[17:25:28.035] Timer tick, asking Buildbucket for the build status
[17:25:28.353] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:28.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:48:0) after 1m0s
[17:26:28.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:48:0)
[17:26:28.470] Timer tick, asking Buildbucket for the build status
[17:26:28.626] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:28.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:49:0) after 1m0s
[17:27:28.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:49:0)
[17:27:28.664] Timer tick, asking Buildbucket for the build status
[17:27:28.788] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:28.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:50:0) after 1m0s
[17:28:28.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:50:0)
[17:28:28.878] Timer tick, asking Buildbucket for the build status
[17:28:29.002] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:29.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:51:0) after 1m0s
[17:29:29.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:51:0)
[17:29:29.052] Timer tick, asking Buildbucket for the build status
[17:29:29.471] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:29.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:52:0) after 1m0s
[17:30:29.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:52:0)
[17:30:29.652] Timer tick, asking Buildbucket for the build status
[17:30:30.244] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:30.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:53:0) after 1m0s
[17:31:30.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:53:0)
[17:31:30.520] Timer tick, asking Buildbucket for the build status
[17:31:30.708] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:30.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:54:0) after 1m0s
[17:32:30.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:54:0)
[17:32:30.710] Timer tick, asking Buildbucket for the build status
[17:32:30.929] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:30.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:55:0) after 1m0s
[17:33:31.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:55:0)
[17:33:31.118] Timer tick, asking Buildbucket for the build status
[17:33:31.324] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:31.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:56:0) after 1m0s
[17:34:31.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:56:0)
[17:34:31.604] Timer tick, asking Buildbucket for the build status
[17:34:31.740] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:31.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:57:0) after 1m0s
[17:35:31.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:57:0)
[17:35:31.800] Timer tick, asking Buildbucket for the build status
[17:35:32.028] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:32.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:58:0) after 1m0s
[17:36:32.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:58:0)
[17:36:32.037] Timer tick, asking Buildbucket for the build status
[17:36:32.165] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:32.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:59:0) after 1m0s
[17:37:32.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:59:0)
[17:37:32.203] Timer tick, asking Buildbucket for the build status
[17:37:32.363] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:32.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:60:0) after 1m0s
[17:38:32.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:60:0)
[17:38:32.389] Timer tick, asking Buildbucket for the build status
[17:38:32.535] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:32.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:61:0) after 1m0s
[17:39:32.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:61:0)
[17:39:32.588] Timer tick, asking Buildbucket for the build status
[17:39:33.025] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:33.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:62:0) after 1m0s
[17:40:33.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:62:0)
[17:40:33.091] Timer tick, asking Buildbucket for the build status
[17:40:33.312] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:33.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:63:0) after 1m0s
[17:41:33.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:63:0)
[17:41:33.451] Timer tick, asking Buildbucket for the build status
[17:41:33.923] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:33.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:64:0) after 1m0s
[17:42:33.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:64:0)
[17:42:33.942] Timer tick, asking Buildbucket for the build status
[17:42:34.834] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:34.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:65:0) after 1m0s
[17:43:34.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:65:0)
[17:43:34.904] Timer tick, asking Buildbucket for the build status
[17:43:35.043] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:35.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:66:0) after 1m0s
[17:44:35.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:66:0)
[17:44:35.264] Timer tick, asking Buildbucket for the build status
[17:44:35.396] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:35.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:67:0) after 1m0s
[17:45:35.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:67:0)
[17:45:35.486] Timer tick, asking Buildbucket for the build status
[17:45:35.626] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:35.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:68:0) after 1m0s
[17:46:35.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:68:0)
[17:46:35.701] Timer tick, asking Buildbucket for the build status
[17:46:35.835] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:35.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:69:0) after 1m0s
[17:47:35.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:69:0)
[17:47:35.951] Timer tick, asking Buildbucket for the build status
[17:47:36.272] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:36.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:70:0) after 1m0s
[17:48:36.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:70:0)
[17:48:36.313] Timer tick, asking Buildbucket for the build status
[17:48:36.615] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:36.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:71:0) after 1m0s
[17:49:36.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:71:0)
[17:49:36.661] Timer tick, asking Buildbucket for the build status
[17:49:36.747] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:36.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:72:0) after 1m0s
[17:50:36.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:72:0)
[17:50:36.781] Timer tick, asking Buildbucket for the build status
[17:50:37.037] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:37.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:73:0) after 1m0s
[17:51:37.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:73:0)
[17:51:37.090] Timer tick, asking Buildbucket for the build status
[17:51:37.845] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:37.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:74:0) after 1m0s
[17:52:37.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:74:0)
[17:52:37.886] Timer tick, asking Buildbucket for the build status
[17:52:38.084] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:38.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:75:0) after 1m0s
[17:53:38.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:75:0)
[17:53:38.182] Timer tick, asking Buildbucket for the build status
[17:53:38.301] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:38.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:76:0) after 1m0s
[17:54:38.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:76:0)
[17:54:38.323] Timer tick, asking Buildbucket for the build status
[17:54:38.485] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:38.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:77:0) after 1m0s
[17:55:38.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:77:0)
[17:55:38.477] Timer tick, asking Buildbucket for the build status
[17:55:38.642] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:38.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:78:0) after 1m0s
[17:56:38.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:78:0)
[17:56:38.688] Timer tick, asking Buildbucket for the build status
[17:56:41.064] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:41.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:79:0) after 1m0s
[17:57:41.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:79:0)
[17:57:41.119] Timer tick, asking Buildbucket for the build status
[17:57:41.652] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:41.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:80:0) after 1m0s
[17:58:41.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:80:0)
[17:58:41.679] Timer tick, asking Buildbucket for the build status
[17:58:41.972] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:41.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:81:0) after 1m0s
[17:59:42.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:81:0)
[17:59:42.076] Timer tick, asking Buildbucket for the build status
[17:59:42.161] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:42.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:82:0) after 1m0s
[18:00:44.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:82:0)
[18:00:44.515] Timer tick, asking Buildbucket for the build status
[18:00:44.739] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:44.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:83:0) after 1m0s
[18:01:45.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:83:0)
[18:01:45.012] Timer tick, asking Buildbucket for the build status
[18:01:45.268] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:45.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:84:0) after 1m0s
[18:02:45.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:84:0)
[18:02:45.308] Timer tick, asking Buildbucket for the build status
[18:02:45.778] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:45.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:85:0) after 1m0s
[18:03:46.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:85:0)
[18:03:46.241] Timer tick, asking Buildbucket for the build status
[18:03:46.810] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:46.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:86:0) after 1m0s
[18:04:46.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:86:0)
[18:04:46.838] Timer tick, asking Buildbucket for the build status
[18:04:47.513] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:47.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:87:0) after 1m0s
[18:05:47.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:87:0)
[18:05:47.574] Timer tick, asking Buildbucket for the build status
[18:05:48.194] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:48.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:88:0) after 1m0s
[18:06:48.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:88:0)
[18:06:48.251] Timer tick, asking Buildbucket for the build status
[18:06:48.687] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:48.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:89:0) after 1m0s
[18:07:48.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:89:0)
[18:07:48.778] Timer tick, asking Buildbucket for the build status
[18:07:49.159] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:49.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:90:0) after 1m0s
[18:08:49.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:90:0)
[18:08:49.184] Timer tick, asking Buildbucket for the build status
[18:08:50.497] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:50.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:91:0) after 1m0s
[18:09:50.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:91:0)
[18:09:50.552] Timer tick, asking Buildbucket for the build status
[18:09:50.830] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:50.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:92:0) after 1m0s
[18:10:50.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:92:0)
[18:10:50.815] Timer tick, asking Buildbucket for the build status
[18:10:51.495] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:51.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:93:0) after 1m0s
[18:11:51.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:93:0)
[18:11:51.502] Timer tick, asking Buildbucket for the build status
[18:11:51.613] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:51.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:94:0) after 1m0s
[18:12:51.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:94:0)
[18:12:51.673] Timer tick, asking Buildbucket for the build status
[18:12:51.765] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:51.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:95:0) after 1m0s
[18:13:51.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:95:0)
[18:13:51.912] Timer tick, asking Buildbucket for the build status
[18:13:53.115] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:53.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:96:0) after 1m0s
[18:14:53.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:96:0)
[18:14:53.363] Timer tick, asking Buildbucket for the build status
[18:14:53.709] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:53.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:97:0) after 1m0s
[18:15:53.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:97:0)
[18:15:53.766] Timer tick, asking Buildbucket for the build status
[18:15:54.140] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:54.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:98:0) after 1m0s
[18:16:54.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:98:0)
[18:16:54.183] Timer tick, asking Buildbucket for the build status
[18:16:54.422] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:54.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:99:0) after 1m0s
[18:17:54.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:99:0)
[18:17:54.539] Timer tick, asking Buildbucket for the build status
[18:17:54.931] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:54.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:100:0) after 1m0s
[18:18:55.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:100:0)
[18:18:55.183] Timer tick, asking Buildbucket for the build status
[18:18:55.346] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:55.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:101:0) after 1m0s
[18:19:55.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:101:0)
[18:19:55.370] Timer tick, asking Buildbucket for the build status
[18:19:55.838] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:55.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:102:0) after 1m0s
[18:20:55.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:102:0)
[18:20:55.892] Timer tick, asking Buildbucket for the build status
[18:20:56.080] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:56.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:103:0) after 1m0s
[18:21:56.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:103:0)
[18:21:56.208] Timer tick, asking Buildbucket for the build status
[18:21:56.347] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:56.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:104:0) after 1m0s
[18:22:56.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:104:0)
[18:22:56.491] Timer tick, asking Buildbucket for the build status
[18:22:56.624] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:56.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:105:0) after 1m0s
[18:23:56.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:105:0)
[18:23:56.801] Timer tick, asking Buildbucket for the build status
[18:23:56.944] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:56.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:106:0) after 1m0s
[18:24:57.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:106:0)
[18:24:57.062] Timer tick, asking Buildbucket for the build status
[18:24:57.680] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:57.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:107:0) after 1m0s
[18:25:57.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:107:0)
[18:25:57.789] Timer tick, asking Buildbucket for the build status
[18:25:58.133] Build 8862189609385616672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:58.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027619672243452816:108:0) after 1m0s
[18:26:26.113] Received PubSub notification, asking Buildbucket for the build status
[18:26:26.281] Build 8862189609385616672: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:26:26.281] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606760779604864",
"created_by": "project:chromium",
"created_ts": "1606754404614684",
"id": "8862189609385616672",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d22d425e1f0b31a635b2706121a16dcfe0c9388b\"}}",
"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\": \"d22d425e1f0b31a635b2706121a16dcfe0c9388b\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-80-7gv4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21543, \"got_angle_revision\": \"5968da649c175c15854f83c1186cc52ecd4bf1bc\", \"got_dawn_revision\": \"2fe7335d34bc59edefd90a9d3f8683eb8ef83817\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"d22d425e1f0b31a635b2706121a16dcfe0c9388b\", \"got_revision_cp\": \"refs/heads/master@{#831868}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"9dff6a3bb5950edd890e5141f2d3d2f3b4ef351e\", \"got_v8_revision\": \"ac4c4dc02664bb5a541f817619e037f60a4b2437\", \"got_v8_revision_cp\": \"refs/heads/8.9.69@{#1}\", \"got_webrtc_revision\": \"bcca3b08a90fccaa6dd8d86f6079f0ca0553ab4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32715}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d22d425e1f0b31a635b2706121a16dcfe0c9388b\", \"swarm_hashes_refs/heads/master(at){#831868}_without_patch\": {\"absl_hardening_tests\": \"cd9b24c3332953efe23a8a6a6f5f960d93af0ae8\", \"accessibility_unittests\": \"f9c6f74cbb0915198e63592f614e92e3bb7d9136\", \"angle_unittests\": \"13d526940b8e24067d15d4cb27109304f309b5ac\", \"app_list_unittests\": \"9a01d5f71a7af41d6d244a5e8e013e93f7f42507\", \"app_shell_unittests\": \"b1c05fb11263e459a8466c99fe4d134a0ba2f548\", \"ash_unittests\": \"68bfdefa250bdf36d2c7b46a3deb4858056ed91f\", \"aura_unittests\": \"5d08b98d53860923a36666ec9c4e0d69012b3632\", \"base_unittests\": \"10f1b753c1471f0edc38655c1b251d7b23a71c29\", \"base_util_unittests\": \"a62c614918edc0dc58a1ec9a84fe626ead4cd2ed\", \"blink_common_unittests\": \"8924408ae86283588c880ae77533a246c4f63f06\", \"blink_fuzzer_unittests\": \"aceee29d7f3c5b2fb931435e786225e28ff0f0b8\", \"blink_heap_unittests\": \"d28f4bc5760fb4b8d2a3293d5e8be2832519a3cb\", \"blink_platform_unittests\": \"161e71dd324dc4231267a1271b6808f2449b54cf\", \"blink_unittests\": \"bc6f4ad7e90928650fd9f30f37c63f1658f0e529\", \"boringssl_crypto_tests\": \"e0f04b351c6c01d2866006025ce520ab4e0cf1ce\", \"boringssl_ssl_tests\": \"2510a7851c7e88ba8342219aa6a7a7f9e3c0a59e\", \"browser_tests\": \"c73d6ad14e5a23311bcf084e6b1d131cd82c4739\", \"capture_unittests\": \"ab43fdffabfe49377fd1ec4e799dd41cf5a77c9c\", \"cast_unittests\": \"2c2c6309695e68aa9bafd752aa4c235e7c6f8156\", \"cc_unittests\": \"c447974482242f060cc13f43b9944a0f8762981b\", \"chrome_app_unittests\": \"7d81e802ff319a15e04245c13850088c279ef597\", \"chromedriver_unittests\": \"4bd29e19a26da8b9642180a1edd3ebc547105800\", \"chromeos_components_unittests\": \"24d8274d259334fbda278e5ec508842e8c0d6b94\", \"chromeos_unittests\": \"bf451349b7282490fb8ed95a2720eacb35ca76df\", \"components_browsertests\": \"6f29bf8558bbed677005ca03b1b89f2ced0042c7\", \"components_unittests\": \"48090cabdf8259cd70b6fa0d2420f04bbdcdab65\", \"compositor_unittests\": \"aa5fdb348b3494449f1a7b0f8c7953c7288ef08d\", \"content_browsertests\": \"5648e855a2977968697485fd1e100aeacfa8809c\", \"content_unittests\": \"af7a7325c267447b7a294c8da9628a87a87e116d\", \"crashpad_tests\": \"883f54ec0487dd9fbb1ae4a221f08c9824268e38\", \"crypto_unittests\": \"aab0e67d4023b9b7b04964c3991249012c9321ef\", \"dbus_unittests\": \"c5027350ecc535cb1ac6e6aca7d06ee7cab586ac\", \"device_unittests\": \"d8737b293885a5d15051222a67b5a1df654c0f69\", \"display_unittests\": \"5f7cd20901fa3010a2200a378a9c2d756f66a60e\", \"events_unittests\": \"81aa2154e2eaf8e7da78260bd818f1e554aa9ab0\", \"exo_unittests\": \"fd28d8f6e50c2c3907feb5c7d51f57c4845f0570\", \"extensions_browsertests\": \"a85d2959d127401e9988ea2b3690f2c51a02dd79\", \"extensions_unittests\": \"6394ce548264c2d75d69553df165ed8b5a9f2152\", \"filesystem_service_unittests\": \"a93556ffacb017c3b3adaffe16c114ac297ea694\", \"gcm_unit_tests\": \"ba4bbe766d5f419e5f6f5b98acfd0ce99f5284b0\", \"gfx_unittests\": \"53b7d3cf1d508b155e3f9609e02c551c48ca9b9c\", \"gin_unittests\": \"7d1e719515ba64500668330d1d0fd5269a3172f5\", \"gl_unittests_ozone\": \"1dc53d2b471996aa4dd6b2e1c863b4b35b2c66a5\", \"google_apis_unittests\": \"5d556f760ed3c44ddf5f3e98590059fdba1c3b5c\", \"gpu_unittests\": \"31f61e32c91fc581b5043cc4f4698e03369798a0\", \"gwp_asan_unittests\": \"188e48ee191d52c2374f31b4d5920d98c0a8ddcf\", \"interactive_ui_tests\": \"9e185456931fd2aa4db512b394ac3fd9cbbccbfb\", \"ipc_tests\": \"a96363c55695cbd0deb4b5ed362060450b7c1e2d\", \"jingle_unittests\": \"f1340c000809d470836cfe5b06f20660a4e5464b\", \"keyboard_unittests\": \"23878b15a6ecaaa35ac8756fc23da13664392662\", \"latency_unittests\": \"4498f8c66508cb7fa8526ce2aa40faf10c987e43\", \"libjingle_xmpp_unittests\": \"de2edbc72c5625fca1f3bc9ba7b1743e3d270137\", \"liburlpattern_unittests\": \"fe2010153421d997e66068dc6e1d3c80e67a2aaa\", \"media_blink_unittests\": \"58829a1dc8c30a2313fea5ef5f99bde75dc17237\", \"media_unittests\": \"e83935eb5d8eb0b445cde43eb21279fa1b8d1008\", \"message_center_unittests\": \"1afe1b566c26b4b0fbcc49c6b0b5c443e294a9d0\", \"midi_unittests\": \"f93fb5d1d55bca6cc2962fc4272b5ec0ea0cae05\", \"mojo_core_unittests\": \"f97aeeb499143ad7b8d897c5b22caf5d87ad8015\", \"mojo_unittests\": \"088bf11fea0440a1546650899924d8bdf0100364\", \"nacl_helper_nonsfi_unittests\": \"6840fd8b03b94dac6cfa72a8dee929dbae08d5a9\", \"nacl_loader_unittests\": \"446d9f5fb599c4a1c1471e18d059b49464a17c14\", \"native_theme_unittests\": \"3f6038c6efb821361f5044d8fa80bdc6c854c867\", \"net_unittests\": \"9d44a459609b4b2bfe48a9e328b9f178eda61e0b\", \"ozone_gl_unittests\": \"2d2976167fce805d0d59f438d2ce91db5503b938\", \"ozone_unittests\": \"f2344503ef188783bb1960b82cce9f1bdf9c7bab\", \"ozone_x11_unittests\": \"b9b1ba0a79871b6c65d106512880f6bbf5384827\", \"pdf_unittests\": \"a1efa429a08dd9acb92117735fb7ea84ebca67db\", \"perfetto_unittests\": \"2287d5b6894681e3dc168b1a35db26ff15fd3e1d\", \"ppapi_unittests\": \"49b4431e117092949e5755d6efc37d67f8af4e74\", \"printing_unittests\": \"77a1e37ea1d3332ff3f3d61dba99001e175d31b4\", \"remoting_unittests\": \"249a31b8440bfdf7114f0a9c4ed24ce632dd8529\", \"sandbox_linux_unittests\": \"f19e127fce54a81f4f4983a11f198f66b87fc701\", \"service_manager_unittests\": \"062f166931b4b8c577c67ce24d916245d07ca6d9\", \"services_unittests\": \"60552fda51995bf19d48ee64797e3cb890e3dacc\", \"shell_dialogs_unittests\": \"20f965eba401cf404278b9171d212111adaa41c0\", \"skia_unittests\": \"734b60601e4b9e0c71ef8c303f42da54090f11d4\", \"snapshot_unittests\": \"c15f58e590935a3c631a303e0bac2aef6fb97aca\", \"sql_unittests\": \"95de2781a7ef0a28ac7f423a778134d9bc90e207\", \"storage_unittests\": \"4e8ca4a629310fcb276d7db661b8d32fe3c47c24\", \"sync_integration_tests\": \"8f2b8d1fb7222ad9d6a3d346d3023e6f701c77fb\", \"traffic_annotation_auditor_unittests\": \"c5fa6586b1513b531dc1d54c98d086fc75cb6021\", \"ui_base_unittests\": \"97c27e5405d948b1773398c4ee12c93584a0c438\", \"ui_chromeos_unittests\": \"01147fbc7c46a2f86eff3e905079329f8e1dde67\", \"ui_touch_selection_unittests\": \"99e58a5b6e41f2ae946ca10665a85b8e98008310\", \"unit_tests\": \"c59110a82feeaf4179a0cbd6f6b2c07678b1cfe6\", \"url_unittests\": \"93744ae66182f9ed9ecf41b56307c7e114ea5b40\", \"usage_time_limit_unittests\": \"dd8ac81585cf66737e77c74810394c646a218345\", \"views_unittests\": \"559e3ced90c4b18bb6a96b38926fdaea69b79506\", \"viz_unittests\": \"ecfde35dd8e7ede88947b26b34d94db448a25ce1\", \"wm_unittests\": \"9b0cd42d2b41f7c72cddf4b673fe27ec3a8b6fd0\", \"wtf_unittests\": \"296e962f113b0a85d31c50557efdf1040d19689c\", \"zlib_unittests\": \"2b94c91fd3e683a40671f87f0e2ca4f6b8cfa0ee\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1b8c0e295e0040ae60b46798151163eecc632ef935bd1ea9777aec71f94caa4f_v2\", \"builder_2295bac873f7edd8c9763e89419d85b38a875955550d968c436d775d3f06377b_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_874b300c24913e8fd09d4e55502c2323a0d822e7e1e6984eec8382ff1b789e99_v2\", \"builder_a15c792d02d243f2865d956ab51326d361a8fcfed3c44b30d209df7676d4718c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-80-7gv4\"], \"image\": [\"chrome-xenial-20112200-f7cdea8df03\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606754408118508",
"status": "COMPLETED",
"status_changed_ts": "1606760780857433",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21543",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d22d425e1f0b31a635b2706121a16dcfe0c9388b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d22d425e1f0b31a635b2706121a16dcfe0c9388b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027619672243452816",
"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/8862189609385616672/+/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:5032d8180d0a2f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606760781084166",
"url": "https://ci.chromium.org/b/8862189609385616672",
"utcnow_ts": "1606760786262985"
}
}
[18:26:26.281] Invocation finished in 1h46m23.776196742s with status SUCCEEDED