[14:53:15.018] New invocation is queued and will start shortly
[14:53:16.138] Starting the invocation (attempt 1)
[14:53:16.220] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:53:16.220] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:53:16.220] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027626391003903376",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a8c773f7712ce7921e6e24723558400cf6a5dc49\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9027626391003903376",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/a8c773f7712ce7921e6e24723558400cf6a5dc49",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a8c773f7712ce7921e6e24723558400cf6a5dc49",
"gitiles_ref:refs/heads/master"
]
}
[14:53:18.031] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606747996416794",
"id": "8862196328868307760",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a8c773f7712ce7921e6e24723558400cf6a5dc49\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606747997527811",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21542",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a8c773f7712ce7921e6e24723558400cf6a5dc49",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a8c773f7712ce7921e6e24723558400cf6a5dc49",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027626391003903376",
"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/8862196328868307760/+/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": "1606747997527992",
"url": "https://ci.chromium.org/b/8862196328868307760",
"utcnow_ts": "1606747998000474"
}
}
[14:53:18.031] Task URL: https://ci.chromium.org/b/8862196328868307760
[14:53:18.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:2:0) after 1m0s
[14:54:18.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:2:0)
[14:54:18.134] Timer tick, asking Buildbucket for the build status
[14:54:18.590] Build 8862196328868307760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:54:18.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:3:0) after 1m0s
[14:55:18.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:3:0)
[14:55:18.717] Timer tick, asking Buildbucket for the build status
[14:55:19.065] Build 8862196328868307760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:55:19.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:4:0) after 1m0s
[14:56:19.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:4:0)
[14:56:19.151] Timer tick, asking Buildbucket for the build status
[14:56:19.260] Build 8862196328868307760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:56:19.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:5:0) after 1m0s
[14:57:19.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:5:0)
[14:57:19.371] Timer tick, asking Buildbucket for the build status
[14:57:19.441] Build 8862196328868307760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:57:19.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:6:0) after 1m0s
[14:58:08.399] Received PubSub notification, asking Buildbucket for the build status
[14:58:10.687] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:19.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:6:0)
[14:58:19.437] Timer tick, asking Buildbucket for the build status
[14:58:19.565] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:19.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:8:0) after 1m0s
[14:59:19.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:8:0)
[14:59:19.682] Timer tick, asking Buildbucket for the build status
[14:59:19.795] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:19.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:9:0) after 1m0s
[15:00:19.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:9:0)
[15:00:19.858] Timer tick, asking Buildbucket for the build status
[15:00:19.924] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:19.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:10:0) after 1m0s
[15:01:20.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:10:0)
[15:01:20.004] Timer tick, asking Buildbucket for the build status
[15:01:20.079] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:20.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:11:0) after 1m0s
[15:02:20.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:11:0)
[15:02:20.142] Timer tick, asking Buildbucket for the build status
[15:02:20.626] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:20.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:12:0) after 1m0s
[15:03:20.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:12:0)
[15:03:20.653] Timer tick, asking Buildbucket for the build status
[15:03:20.942] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:20.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:13:0) after 1m0s
[15:04:20.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:13:0)
[15:04:20.930] Timer tick, asking Buildbucket for the build status
[15:04:21.183] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:21.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:14:0) after 1m0s
[15:05:21.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:14:0)
[15:05:21.314] Timer tick, asking Buildbucket for the build status
[15:05:21.455] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:21.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:15:0) after 1m0s
[15:06:21.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:15:0)
[15:06:21.525] Timer tick, asking Buildbucket for the build status
[15:06:22.753] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:22.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:16:0) after 1m0s
[15:07:22.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:16:0)
[15:07:22.788] Timer tick, asking Buildbucket for the build status
[15:07:22.914] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:22.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:17:0) after 1m0s
[15:08:22.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:17:0)
[15:08:22.943] Timer tick, asking Buildbucket for the build status
[15:08:23.077] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:23.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:18:0) after 1m0s
[15:09:23.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:18:0)
[15:09:23.106] Timer tick, asking Buildbucket for the build status
[15:09:23.216] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:23.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:19:0) after 1m0s
[15:10:23.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:19:0)
[15:10:23.236] Timer tick, asking Buildbucket for the build status
[15:10:23.525] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:23.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:20:0) after 1m0s
[15:11:23.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:20:0)
[15:11:23.801] Timer tick, asking Buildbucket for the build status
[15:11:24.149] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:24.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:21:0) after 1m0s
[15:12:24.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:21:0)
[15:12:24.201] Timer tick, asking Buildbucket for the build status
[15:12:24.366] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:24.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:22:0) after 1m0s
[15:13:24.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:22:0)
[15:13:24.377] Timer tick, asking Buildbucket for the build status
[15:13:24.430] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:24.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:23:0) after 1m0s
[15:14:24.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:23:0)
[15:14:24.561] Timer tick, asking Buildbucket for the build status
[15:14:24.820] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:24.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:24:0) after 1m0s
[15:15:24.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:24:0)
[15:15:24.853] Timer tick, asking Buildbucket for the build status
[15:15:25.105] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:25.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:25:0) after 1m0s
[15:16:25.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:25:0)
[15:16:25.196] Timer tick, asking Buildbucket for the build status
[15:16:25.284] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:25.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:26:0) after 1m0s
[15:17:25.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:26:0)
[15:17:25.410] Timer tick, asking Buildbucket for the build status
[15:17:25.762] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:25.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:27:0) after 1m0s
[15:18:25.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:27:0)
[15:18:25.787] Timer tick, asking Buildbucket for the build status
[15:18:26.103] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:26.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:28:0) after 1m0s
[15:19:26.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:28:0)
[15:19:26.140] Timer tick, asking Buildbucket for the build status
[15:19:26.255] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:26.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:29:0) after 1m0s
[15:20:26.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:29:0)
[15:20:26.234] Timer tick, asking Buildbucket for the build status
[15:20:26.473] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:26.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:30:0) after 1m0s
[15:21:26.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:30:0)
[15:21:26.546] Timer tick, asking Buildbucket for the build status
[15:21:27.358] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:27.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:31:0) after 1m0s
[15:22:27.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:31:0)
[15:22:27.412] Timer tick, asking Buildbucket for the build status
[15:22:27.658] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:27.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:32:0) after 1m0s
[15:23:27.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:32:0)
[15:23:27.634] Timer tick, asking Buildbucket for the build status
[15:23:28.002] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:28.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:33:0) after 1m0s
[15:24:28.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:33:0)
[15:24:28.032] Timer tick, asking Buildbucket for the build status
[15:24:28.376] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:28.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:34:0) after 1m0s
[15:25:28.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:34:0)
[15:25:28.440] Timer tick, asking Buildbucket for the build status
[15:25:28.622] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:28.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:35:0) after 1m0s
[15:26:28.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:35:0)
[15:26:28.744] Timer tick, asking Buildbucket for the build status
[15:26:28.958] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:28.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:36:0) after 1m0s
[15:27:29.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:36:0)
[15:27:29.047] Timer tick, asking Buildbucket for the build status
[15:27:29.161] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:29.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:37:0) after 1m0s
[15:28:29.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:37:0)
[15:28:29.216] Timer tick, asking Buildbucket for the build status
[15:28:29.382] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:29.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:38:0) after 1m0s
[15:29:29.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:38:0)
[15:29:29.446] Timer tick, asking Buildbucket for the build status
[15:30:08.033] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:08.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:39:0) after 1m0s
[15:31:08.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:39:0)
[15:31:08.071] Timer tick, asking Buildbucket for the build status
[15:31:08.209] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:08.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:40:0) after 1m0s
[15:32:08.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:40:0)
[15:32:08.255] Timer tick, asking Buildbucket for the build status
[15:32:08.508] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:08.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:41:0) after 1m0s
[15:33:08.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:41:0)
[15:33:08.608] Timer tick, asking Buildbucket for the build status
[15:33:08.862] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:08.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:42:0) after 1m0s
[15:34:08.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:42:0)
[15:34:08.916] Timer tick, asking Buildbucket for the build status
[15:34:09.058] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:09.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:43:0) after 1m0s
[15:35:09.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:43:0)
[15:35:09.102] Timer tick, asking Buildbucket for the build status
[15:35:09.969] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:09.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:44:0) after 1m0s
[15:36:10.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:44:0)
[15:36:10.099] Timer tick, asking Buildbucket for the build status
[15:36:10.893] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:10.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:45:0) after 1m0s
[15:37:10.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:45:0)
[15:37:10.938] Timer tick, asking Buildbucket for the build status
[15:37:11.064] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:11.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:46:0) after 1m0s
[15:38:11.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:46:0)
[15:38:11.103] Timer tick, asking Buildbucket for the build status
[15:38:11.465] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:11.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:47:0) after 1m0s
[15:39:11.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:47:0)
[15:39:11.499] Timer tick, asking Buildbucket for the build status
[15:39:11.748] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:11.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:48:0) after 1m0s
[15:40:11.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:48:0)
[15:40:11.931] Timer tick, asking Buildbucket for the build status
[15:40:12.052] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:12.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:49:0) after 1m0s
[15:41:12.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:49:0)
[15:41:12.110] Timer tick, asking Buildbucket for the build status
[15:41:13.435] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:13.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:50:0) after 1m0s
[15:42:13.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:50:0)
[15:42:13.484] Timer tick, asking Buildbucket for the build status
[15:42:13.539] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:13.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:51:0) after 1m0s
[15:43:13.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:51:0)
[15:43:13.559] Timer tick, asking Buildbucket for the build status
[15:43:13.758] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:13.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:52:0) after 1m0s
[15:44:13.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:52:0)
[15:44:13.788] Timer tick, asking Buildbucket for the build status
[15:44:13.962] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:13.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:53:0) after 1m0s
[15:45:13.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:53:0)
[15:45:13.993] Timer tick, asking Buildbucket for the build status
[15:45:14.712] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:14.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:54:0) after 1m0s
[15:46:14.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:54:0)
[15:46:14.775] Timer tick, asking Buildbucket for the build status
[15:46:15.019] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:15.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:55:0) after 1m0s
[15:47:15.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:55:0)
[15:47:15.072] Timer tick, asking Buildbucket for the build status
[15:47:15.153] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:15.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:56:0) after 1m0s
[15:48:15.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:56:0)
[15:48:15.263] Timer tick, asking Buildbucket for the build status
[15:48:15.351] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:15.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:57:0) after 1m0s
[15:49:15.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:57:0)
[15:49:15.442] Timer tick, asking Buildbucket for the build status
[15:49:15.907] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:15.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:58:0) after 1m0s
[15:50:16.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:58:0)
[15:50:16.014] Timer tick, asking Buildbucket for the build status
[15:50:16.146] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:16.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:59:0) after 1m0s
[15:51:16.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:59:0)
[15:51:16.216] Timer tick, asking Buildbucket for the build status
[15:51:16.373] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:16.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:60:0) after 1m0s
[15:52:16.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:60:0)
[15:52:16.455] Timer tick, asking Buildbucket for the build status
[15:52:16.843] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:16.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:61:0) after 1m0s
[15:53:16.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:61:0)
[15:53:16.981] Timer tick, asking Buildbucket for the build status
[15:53:18.205] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:18.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:62:0) after 1m0s
[15:54:18.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:62:0)
[15:54:18.309] Timer tick, asking Buildbucket for the build status
[15:54:23.326] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:23.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:63:0) after 1m0s
[15:55:23.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:63:0)
[15:55:23.373] Timer tick, asking Buildbucket for the build status
[15:55:23.520] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:23.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:64:0) after 1m0s
[15:56:23.541] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:64:0)
[15:56:23.541] Timer tick, asking Buildbucket for the build status
[15:56:23.745] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:23.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:65:0) after 1m0s
[15:57:23.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:65:0)
[15:57:23.766] Timer tick, asking Buildbucket for the build status
[15:57:24.713] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:24.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:66:0) after 1m0s
[15:58:24.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:66:0)
[15:58:24.882] Timer tick, asking Buildbucket for the build status
[15:58:24.973] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:24.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:67:0) after 1m0s
[15:59:25.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:67:0)
[15:59:25.035] Timer tick, asking Buildbucket for the build status
[15:59:26.757] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:26.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:68:0) after 1m0s
[16:00:26.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:68:0)
[16:00:26.812] Timer tick, asking Buildbucket for the build status
[16:00:26.921] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:26.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:69:0) after 1m0s
[16:01:27.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:69:0)
[16:01:27.004] Timer tick, asking Buildbucket for the build status
[16:01:27.558] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:27.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:70:0) after 1m0s
[16:02:27.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:70:0)
[16:02:27.606] Timer tick, asking Buildbucket for the build status
[16:02:27.768] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:27.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:71:0) after 1m0s
[16:03:27.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:71:0)
[16:03:27.797] Timer tick, asking Buildbucket for the build status
[16:03:27.902] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:27.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:72:0) after 1m0s
[16:04:27.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:72:0)
[16:04:27.987] Timer tick, asking Buildbucket for the build status
[16:04:28.118] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:28.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:73:0) after 1m0s
[16:05:28.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:73:0)
[16:05:28.270] Timer tick, asking Buildbucket for the build status
[16:05:28.518] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:28.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:74:0) after 1m0s
[16:06:28.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:74:0)
[16:06:28.594] Timer tick, asking Buildbucket for the build status
[16:06:28.678] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:28.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:75:0) after 1m0s
[16:07:28.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:75:0)
[16:07:28.710] Timer tick, asking Buildbucket for the build status
[16:07:28.866] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:28.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:76:0) after 1m0s
[16:08:28.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:76:0)
[16:08:28.920] Timer tick, asking Buildbucket for the build status
[16:08:29.097] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:29.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:77:0) after 1m0s
[16:09:29.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:77:0)
[16:09:29.117] Timer tick, asking Buildbucket for the build status
[16:09:29.445] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:29.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:78:0) after 1m0s
[16:10:29.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:78:0)
[16:10:29.540] Timer tick, asking Buildbucket for the build status
[16:10:29.774] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:29.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:79:0) after 1m0s
[16:11:29.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:79:0)
[16:11:29.806] Timer tick, asking Buildbucket for the build status
[16:11:30.344] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:30.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:80:0) after 1m0s
[16:12:30.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:80:0)
[16:12:30.366] Timer tick, asking Buildbucket for the build status
[16:12:30.773] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:30.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:81:0) after 1m0s
[16:13:30.861] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:81:0)
[16:13:30.861] Timer tick, asking Buildbucket for the build status
[16:13:31.211] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:31.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:82:0) after 1m0s
[16:14:31.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:82:0)
[16:14:31.217] Timer tick, asking Buildbucket for the build status
[16:14:31.766] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:31.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:83:0) after 1m0s
[16:15:31.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:83:0)
[16:15:31.864] Timer tick, asking Buildbucket for the build status
[16:15:31.984] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:31.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:84:0) after 1m0s
[16:16:32.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:84:0)
[16:16:32.077] Timer tick, asking Buildbucket for the build status
[16:16:32.232] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:32.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:85:0) after 1m0s
[16:17:32.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:85:0)
[16:17:32.468] Timer tick, asking Buildbucket for the build status
[16:17:32.567] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:32.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:86:0) after 1m0s
[16:18:32.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:86:0)
[16:18:32.654] Timer tick, asking Buildbucket for the build status
[16:18:33.258] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:33.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:87:0) after 1m0s
[16:19:33.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:87:0)
[16:19:33.361] Timer tick, asking Buildbucket for the build status
[16:19:33.462] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:33.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:88:0) after 1m0s
[16:20:33.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:88:0)
[16:20:33.471] Timer tick, asking Buildbucket for the build status
[16:20:34.186] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:34.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:89:0) after 1m0s
[16:21:34.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:89:0)
[16:21:34.244] Timer tick, asking Buildbucket for the build status
[16:21:34.945] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:34.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:90:0) after 1m0s
[16:22:34.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:90:0)
[16:22:34.972] Timer tick, asking Buildbucket for the build status
[16:22:36.027] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:36.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:91:0) after 1m0s
[16:23:36.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:91:0)
[16:23:36.032] Timer tick, asking Buildbucket for the build status
[16:23:37.079] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:37.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:92:0) after 1m0s
[16:24:37.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:92:0)
[16:24:37.102] Timer tick, asking Buildbucket for the build status
[16:24:37.229] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:37.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:93:0) after 1m0s
[16:25:37.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:93:0)
[16:25:37.251] Timer tick, asking Buildbucket for the build status
[16:25:37.327] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:37.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:94:0) after 1m0s
[16:26:37.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:94:0)
[16:26:37.397] Timer tick, asking Buildbucket for the build status
[16:26:37.472] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:37.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:95:0) after 1m0s
[16:27:37.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:95:0)
[16:27:37.519] Timer tick, asking Buildbucket for the build status
[16:27:37.616] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:37.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:96:0) after 1m0s
[16:28:37.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:96:0)
[16:28:37.677] Timer tick, asking Buildbucket for the build status
[16:28:38.585] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:38.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:97:0) after 1m0s
[16:29:38.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:97:0)
[16:29:38.661] Timer tick, asking Buildbucket for the build status
[16:29:38.985] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:38.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:98:0) after 1m0s
[16:30:39.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:98:0)
[16:30:39.044] Timer tick, asking Buildbucket for the build status
[16:30:39.161] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:39.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:99:0) after 1m0s
[16:31:39.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:99:0)
[16:31:39.499] Timer tick, asking Buildbucket for the build status
[16:31:39.717] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:39.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:100:0) after 1m0s
[16:32:39.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:100:0)
[16:32:39.770] Timer tick, asking Buildbucket for the build status
[16:32:39.847] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:39.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:101:0) after 1m0s
[16:33:39.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:101:0)
[16:33:39.874] Timer tick, asking Buildbucket for the build status
[16:33:40.143] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:40.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:102:0) after 1m0s
[16:34:40.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:102:0)
[16:34:40.208] Timer tick, asking Buildbucket for the build status
[16:34:40.356] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:40.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:103:0) after 1m0s
[16:35:40.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:103:0)
[16:35:40.468] Timer tick, asking Buildbucket for the build status
[16:35:41.928] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:41.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:104:0) after 1m0s
[16:36:42.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:104:0)
[16:36:42.002] Timer tick, asking Buildbucket for the build status
[16:36:42.184] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:42.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:105:0) after 1m0s
[16:37:42.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:105:0)
[16:37:42.232] Timer tick, asking Buildbucket for the build status
[16:37:42.479] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:42.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:106:0) after 1m0s
[16:38:42.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:106:0)
[16:38:42.680] Timer tick, asking Buildbucket for the build status
[16:38:43.037] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:43.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:107:0) after 1m0s
[16:39:43.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:107:0)
[16:39:43.125] Timer tick, asking Buildbucket for the build status
[16:39:43.417] Build 8862196328868307760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:43.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027626391003903376:108:0) after 1m0s
[16:39:59.780] Received PubSub notification, asking Buildbucket for the build status
[16:40:00.284] Build 8862196328868307760: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:40:00.284] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606754398540615",
"created_by": "project:chromium",
"created_ts": "1606747996416794",
"id": "8862196328868307760",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a8c773f7712ce7921e6e24723558400cf6a5dc49\"}}",
"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\": \"a8c773f7712ce7921e6e24723558400cf6a5dc49\", \"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\": 21542, \"got_angle_revision\": \"3d061021c920ada75c5d9ab2424ca5a037607212\", \"got_dawn_revision\": \"d8bb0bb7c735173219d7a8ffec18eee1813ff302\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"a8c773f7712ce7921e6e24723558400cf6a5dc49\", \"got_revision_cp\": \"refs/heads/master@{#831839}\", \"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\": \"a8c773f7712ce7921e6e24723558400cf6a5dc49\", \"swarm_hashes_refs/heads/master(at){#831839}_without_patch\": {\"absl_hardening_tests\": \"763c5b295aa72e9840d996032b60bafd0e35321d\", \"accessibility_unittests\": \"71902964edf8fe34238075ef6aaa38f82a9d6e8b\", \"angle_unittests\": \"89745089e87168e0612f36afbb08cf60044c2650\", \"app_list_unittests\": \"69eb0bda7d7a9f819ca7954c8e229a6b3d6942cc\", \"app_shell_unittests\": \"06683a74c41f2f667f5dce2dbd69c278c188fc62\", \"ash_unittests\": \"b3834511a66ef82f08534be3a84c5bc0258ff349\", \"aura_unittests\": \"527f41027d4005f52679b89a2521a3fc17f75257\", \"base_unittests\": \"bb0ca165da268e1b41aca6611dc7fd88da08f8ad\", \"base_util_unittests\": \"0d834275a3fd43e38ba06cefe8d880f3285b4f85\", \"blink_common_unittests\": \"aff26102a284ad9bdfa9a5a6bb93c3f9f9df6596\", \"blink_fuzzer_unittests\": \"4abe1ea2efae7ec2e721b2f899a968d48aabb395\", \"blink_heap_unittests\": \"5fb60b50505493367d23b193c145230ed2744be8\", \"blink_platform_unittests\": \"b80e5d90e4d8f56e9ba3c23e75a9605686ec4a4f\", \"blink_unittests\": \"360e4155e083bc4be0521a07b70eab4e4d60077c\", \"boringssl_crypto_tests\": \"7bcea3c47bfc4c775f4c3984922d0bfab8762ee6\", \"boringssl_ssl_tests\": \"d51e254a757bc53d0fdd838cde364046390fd85b\", \"browser_tests\": \"b03601b0bf9b69f8803f724a7cfc08e77f9ab56b\", \"capture_unittests\": \"2ea9cf1794edcc4611b639935c77c40fc6853133\", \"cast_unittests\": \"ec9d7e5e907af2c9eeb416f221fbdb64db3a6782\", \"cc_unittests\": \"0f9eb62cbb6839d1f50987525db50888da425edf\", \"chrome_app_unittests\": \"76ef5cfe0540e95a98f3d00b215136e6f7799ae0\", \"chromedriver_unittests\": \"7aa1dbb9e66e274634493537be0b590e21aec68b\", \"chromeos_components_unittests\": \"8809fb99175ac78af3e5da95afe2817914a77536\", \"chromeos_unittests\": \"ff284fefb3f72c54332a5c4a8e42e12272842360\", \"components_browsertests\": \"86df86e57f400ff94bc59da8dd0029690ae8055e\", \"components_unittests\": \"2d127e6f7f36f78f4fc7926242b8299102127d50\", \"compositor_unittests\": \"502b88f54680671055dce55f363b3ca0c4bb0081\", \"content_browsertests\": \"878c1dfbc268bdfa2c53067e5a6a38d5dc54fb1d\", \"content_unittests\": \"3ff104eabb1b3f06d53d3d29f50e8892c7b0fc64\", \"crashpad_tests\": \"a9488dac625094864f3ed631367886cdfe97d956\", \"crypto_unittests\": \"409df45f00af882777fc8d3e45443a0db692a691\", \"dbus_unittests\": \"3cb574f340689e85a249f656f84ea6fa85648513\", \"device_unittests\": \"fc4c86d4b504daf9a37cda26db8979d472f4a2f2\", \"display_unittests\": \"c019804ad7bcab096fcb17c4844ea6e70889b50f\", \"events_unittests\": \"ecbdb9b01feb7456926ca67eb68e96d4d25e3c08\", \"exo_unittests\": \"46e27f68304ecc32f1ee882c0eb5fea958071993\", \"extensions_browsertests\": \"b2c324a6b2f2a6346e6d5d22cd82696002bcc76b\", \"extensions_unittests\": \"7d4a36a10ebaf66cc4931e170b521dae7787854d\", \"filesystem_service_unittests\": \"4e034769a017e2c3baae97f5a4a0bacd49e6db39\", \"gcm_unit_tests\": \"3dd86d056e18fa78d97ba2bda5f691eb360b7b67\", \"gfx_unittests\": \"a60005038516e48dbbe32d49427a3df974c78623\", \"gin_unittests\": \"5a8b6948b44ca5935f57c3fb56d4dd41845df451\", \"gl_unittests_ozone\": \"c0a9ec57a8b708fda98f542029094c0a6de5b45b\", \"google_apis_unittests\": \"8475de164657b5262a4efbce746671222f96d0a0\", \"gpu_unittests\": \"9c20da4084b5d1b8e9d0be69c69da2b49e2e5965\", \"gwp_asan_unittests\": \"48f6e98f66cee7ec11415288f396481034c5cd0a\", \"interactive_ui_tests\": \"d521a3f1232b6d7c3b27fdb4e39a593f932b9722\", \"ipc_tests\": \"a4bc7f70f08a21067a91e02a6240b2cb86e90289\", \"jingle_unittests\": \"1775d34924caffce815fd996058284c49e3b0f8d\", \"keyboard_unittests\": \"e454b1e44f301bf6ac665a5f71643e4bffe6df93\", \"latency_unittests\": \"828d57f36fb7ce2babace7dac05c00335c031de1\", \"libjingle_xmpp_unittests\": \"d68c7f0271e0a33077220a3bdf6c6abaa665ad89\", \"liburlpattern_unittests\": \"7f089135d2712af5fa383e6fb7b4d1cb8a068ef4\", \"media_blink_unittests\": \"5dbd9896b9fffce2ed8a8ab1361b5608ff248aa6\", \"media_unittests\": \"8598fc9a6d919ece2cb7ff427e415af1975cd23a\", \"message_center_unittests\": \"749c335bf9a8d99031cb2bebecdacbbc61a5752a\", \"midi_unittests\": \"464efe98ef1de6a1a3b48f57475224b9fea57526\", \"mojo_core_unittests\": \"7ceae77377a473e32f09c6f625bb142eb967e3e7\", \"mojo_unittests\": \"db00faf1378d9fe9e9702c9f5653c840472929c3\", \"nacl_helper_nonsfi_unittests\": \"12a84a2ee300fde36846a13a0835859b1a79fab5\", \"nacl_loader_unittests\": \"4cb0457c1c12577b707d407e4f9ac3454c0535da\", \"native_theme_unittests\": \"58dc85e144b7e015c612c75179552298fef57d70\", \"net_unittests\": \"02ae3ba9e90818dc5c4a86cf93ce4b2c1cc170d2\", \"ozone_gl_unittests\": \"c4873cd2b69f51d931f37905a02df773253b729c\", \"ozone_unittests\": \"9fd671bb805897e86f0dfe8bef1a25b9ac5bd232\", \"ozone_x11_unittests\": \"4f7d4837a53870fcf653c4e6c17824089ac0ed5c\", \"pdf_unittests\": \"291dfe5f39868361739bc804505ff514912d37f1\", \"perfetto_unittests\": \"9f8feb73f68d3b8985f39d299f3190ac4cffbdf3\", \"ppapi_unittests\": \"ce49800cc08326db4de70268fac211321d350368\", \"printing_unittests\": \"b21e6ecc32075bb0b4ac4b887dfcc318cda7d13f\", \"remoting_unittests\": \"eefd37b33baf1bffc0fb36007e993d69b7d0c396\", \"sandbox_linux_unittests\": \"cb9f004572fd643d95b102a49155d2aa53ac6b6d\", \"service_manager_unittests\": \"a5936a14b390480dd7691f1ef60224629795ec79\", \"services_unittests\": \"9e1d4e15ce7ce6f4d618ff0c9ede045fc4d96520\", \"shell_dialogs_unittests\": \"b8d58c717d2aaa3aa6fa5447c834fc403ed87e1c\", \"skia_unittests\": \"aa6021712956c38b23933bc4385aa67e92eb7e9c\", \"snapshot_unittests\": \"df17c4e3b78ce2000de8d515a537d8ef5a30b7dc\", \"sql_unittests\": \"49c4e6c40c6b791cc5f9e5e4151c93e6bc85d192\", \"storage_unittests\": \"5ac06c7b3356c34ae73f7fb945587b0cb3ee3526\", \"sync_integration_tests\": \"bf88daa640ddb3495ce2837fd098fcd0325b91c1\", \"traffic_annotation_auditor_unittests\": \"608f295a521d4c1e6d6ea7548ee79ce1b77a23f6\", \"ui_base_unittests\": \"4688214030484b49d479d2303aa4f806cf4005e0\", \"ui_chromeos_unittests\": \"96554d0d0027392f0d118e0ef7329cfc8bc344ea\", \"ui_touch_selection_unittests\": \"b84557993d6e2ef51bc8da02b1669eff805611c0\", \"unit_tests\": \"47ec0206e8cb8269839c9070463b7a43c1c95096\", \"url_unittests\": \"74d6f15c8b7199a99402b8ef0e2f886dc250bbbd\", \"usage_time_limit_unittests\": \"31c6da441d3b95f039f7363d381e4932aecb5b15\", \"views_unittests\": \"e707ee6849b4e8a6b7d46fc75bb5525a5a13bbe6\", \"viz_unittests\": \"be807f10f2aa491fd75342a3affbe05d1f183d95\", \"wm_unittests\": \"0e00cf58e0a2a3a227d33cb7dd977b1028eee0c4\", \"wtf_unittests\": \"625b82f8d3c3a1b81794adc35ea2fa32e8a50fcd\", \"zlib_unittests\": \"24a600270c0760c68f1451712285ea37223c98b4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1b8c0e295e0040ae60b46798151163eecc632ef935bd1ea9777aec71f94caa4f_v2\", \"builder_2295bac873f7edd8c9763e89419d85b38a875955550d968c436d775d3f06377b_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": "1606748284218290",
"status": "COMPLETED",
"status_changed_ts": "1606754398978279",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21542",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a8c773f7712ce7921e6e24723558400cf6a5dc49",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a8c773f7712ce7921e6e24723558400cf6a5dc49",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027626391003903376",
"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/8862196328868307760/+/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:50327653a5946a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606754398987956",
"url": "https://ci.chromium.org/b/8862196328868307760",
"utcnow_ts": "1606754400060554"
}
}
[16:40:00.284] Invocation finished in 1h46m45.287784458s with status SUCCEEDED