[08:04:57.143] New invocation is queued and will start shortly
[08:04:58.429] Starting the invocation (attempt 1)
[08:04:58.469] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:04:58.469] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:04:58.469] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025840139555763872",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"cfcbc37819fdd0337d9232bf75b85a752793b4ce\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9025840139555763872",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/cfcbc37819fdd0337d9232bf75b85a752793b4ce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cfcbc37819fdd0337d9232bf75b85a752793b4ce",
"gitiles_ref:refs/heads/master"
]
}
[08:04:59.818] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608451498589421",
"id": "8860410077374149904",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cfcbc37819fdd0337d9232bf75b85a752793b4ce\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608451499473920",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178837",
"builder:Linux Builder (dbg)",
"buildset:commit/git/cfcbc37819fdd0337d9232bf75b85a752793b4ce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cfcbc37819fdd0337d9232bf75b85a752793b4ce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025840139555763872",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8860410077374149904/+/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": "1608451499474020",
"url": "https://ci.chromium.org/b/8860410077374149904",
"utcnow_ts": "1608451499811634"
}
}
[08:04:59.818] Task URL: https://ci.chromium.org/b/8860410077374149904
[08:04:59.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:2:0) after 1m0s
[08:05:59.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:2:0)
[08:05:59.857] Timer tick, asking Buildbucket for the build status
[08:05:59.982] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:05:59.982] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:3:0) after 1m0s
[08:07:00.006] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:3:0)
[08:07:00.006] Timer tick, asking Buildbucket for the build status
[08:07:00.225] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:07:00.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:4:0) after 1m0s
[08:08:00.279] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:4:0)
[08:08:00.279] Timer tick, asking Buildbucket for the build status
[08:08:00.580] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:08:00.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:5:0) after 1m0s
[08:09:00.606] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:5:0)
[08:09:00.606] Timer tick, asking Buildbucket for the build status
[08:09:00.686] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:09:00.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:6:0) after 1m0s
[08:10:00.840] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:6:0)
[08:10:00.840] Timer tick, asking Buildbucket for the build status
[08:10:01.116] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:10:01.116] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:7:0) after 1m0s
[08:11:01.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:7:0)
[08:11:01.138] Timer tick, asking Buildbucket for the build status
[08:11:01.399] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:11:01.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:8:0) after 1m0s
[08:12:01.457] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:8:0)
[08:12:01.457] Timer tick, asking Buildbucket for the build status
[08:12:01.604] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:12:01.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:9:0) after 1m0s
[08:13:01.694] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:9:0)
[08:13:01.694] Timer tick, asking Buildbucket for the build status
[08:13:02.073] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:13:02.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:10:0) after 1m0s
[08:14:02.094] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:10:0)
[08:14:02.094] Timer tick, asking Buildbucket for the build status
[08:14:02.230] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:14:02.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:11:0) after 1m0s
[08:15:02.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:11:0)
[08:15:02.209] Timer tick, asking Buildbucket for the build status
[08:15:02.310] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:15:02.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:12:0) after 1m0s
[08:16:02.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:12:0)
[08:16:02.422] Timer tick, asking Buildbucket for the build status
[08:16:02.573] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:16:02.573] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:13:0) after 1m0s
[08:17:02.704] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:13:0)
[08:17:02.704] Timer tick, asking Buildbucket for the build status
[08:17:02.778] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:17:02.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:14:0) after 1m0s
[08:18:02.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:14:0)
[08:18:02.860] Timer tick, asking Buildbucket for the build status
[08:18:03.108] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:18:03.108] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:15:0) after 1m0s
[08:19:03.126] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:15:0)
[08:19:03.126] Timer tick, asking Buildbucket for the build status
[08:19:04.071] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:19:04.071] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:16:0) after 1m0s
[08:20:04.184] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:16:0)
[08:20:04.184] Timer tick, asking Buildbucket for the build status
[08:20:04.640] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:20:04.640] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:17:0) after 1m0s
[08:21:04.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:17:0)
[08:21:04.952] Timer tick, asking Buildbucket for the build status
[08:21:05.109] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:21:05.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:18:0) after 1m0s
[08:22:05.151] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:18:0)
[08:22:05.151] Timer tick, asking Buildbucket for the build status
[08:22:05.241] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:22:05.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:19:0) after 1m0s
[08:23:05.420] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:19:0)
[08:23:05.420] Timer tick, asking Buildbucket for the build status
[08:23:05.481] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:23:05.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:20:0) after 1m0s
[08:24:05.519] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:20:0)
[08:24:05.519] Timer tick, asking Buildbucket for the build status
[08:24:05.764] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:24:05.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:21:0) after 1m0s
[08:25:05.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:21:0)
[08:25:05.839] Timer tick, asking Buildbucket for the build status
[08:25:05.939] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:25:05.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:22:0) after 1m0s
[08:26:05.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:22:0)
[08:26:05.937] Timer tick, asking Buildbucket for the build status
[08:26:06.173] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:26:06.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:23:0) after 1m0s
[08:27:06.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:23:0)
[08:27:06.204] Timer tick, asking Buildbucket for the build status
[08:27:06.379] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:27:06.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:24:0) after 1m0s
[08:28:06.412] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:24:0)
[08:28:06.412] Timer tick, asking Buildbucket for the build status
[08:28:06.613] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:28:06.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:25:0) after 1m0s
[08:29:06.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:25:0)
[08:29:06.632] Timer tick, asking Buildbucket for the build status
[08:29:06.695] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:29:06.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:26:0) after 1m0s
[08:30:06.694] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:26:0)
[08:30:06.694] Timer tick, asking Buildbucket for the build status
[08:30:06.808] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:30:06.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:27:0) after 1m0s
[08:31:06.865] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:27:0)
[08:31:06.865] Timer tick, asking Buildbucket for the build status
[08:31:07.057] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:31:07.057] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:28:0) after 1m0s
[08:32:07.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:28:0)
[08:32:07.095] Timer tick, asking Buildbucket for the build status
[08:32:07.724] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:32:07.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:29:0) after 1m0s
[08:33:07.747] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:29:0)
[08:33:07.747] Timer tick, asking Buildbucket for the build status
[08:33:07.916] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:33:07.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:30:0) after 1m0s
[08:34:07.936] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:30:0)
[08:34:07.936] Timer tick, asking Buildbucket for the build status
[08:34:08.033] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:34:08.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:31:0) after 1m0s
[08:35:08.090] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:31:0)
[08:35:08.090] Timer tick, asking Buildbucket for the build status
[08:35:08.563] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:35:08.563] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:32:0) after 1m0s
[08:36:08.586] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:32:0)
[08:36:08.586] Timer tick, asking Buildbucket for the build status
[08:36:08.656] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:36:08.656] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:33:0) after 1m0s
[08:37:08.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:33:0)
[08:37:08.679] Timer tick, asking Buildbucket for the build status
[08:37:08.898] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:37:08.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:34:0) after 1m0s
[08:38:08.966] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:34:0)
[08:38:08.966] Timer tick, asking Buildbucket for the build status
[08:38:09.955] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:38:09.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:35:0) after 1m0s
[08:39:10.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:35:0)
[08:39:10.038] Timer tick, asking Buildbucket for the build status
[08:39:10.099] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:39:10.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:36:0) after 1m0s
[08:40:10.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:36:0)
[08:40:10.138] Timer tick, asking Buildbucket for the build status
[08:40:10.299] Build 8860410077374149904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:40:10.299] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:37:0) after 1m0s
[08:40:36.195] Received PubSub notification, asking Buildbucket for the build status
[08:40:36.375] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:10.419] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:37:0)
[08:41:10.419] Timer tick, asking Buildbucket for the build status
[08:41:10.476] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:10.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:39:0) after 1m0s
[08:42:10.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:39:0)
[08:42:10.503] Timer tick, asking Buildbucket for the build status
[08:42:10.561] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:10.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:40:0) after 1m0s
[08:43:10.616] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:40:0)
[08:43:10.616] Timer tick, asking Buildbucket for the build status
[08:43:10.726] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:10.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:41:0) after 1m0s
[08:44:10.745] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:41:0)
[08:44:10.745] Timer tick, asking Buildbucket for the build status
[08:44:10.807] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:10.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:42:0) after 1m0s
[08:45:10.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:42:0)
[08:45:10.839] Timer tick, asking Buildbucket for the build status
[08:45:10.952] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:10.952] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:43:0) after 1m0s
[08:46:11.046] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:43:0)
[08:46:11.046] Timer tick, asking Buildbucket for the build status
[08:46:11.111] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:11.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:44:0) after 1m0s
[08:47:11.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:44:0)
[08:47:11.212] Timer tick, asking Buildbucket for the build status
[08:47:11.307] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:11.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:45:0) after 1m0s
[08:48:11.309] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:45:0)
[08:48:11.309] Timer tick, asking Buildbucket for the build status
[08:48:11.366] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:11.366] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:46:0) after 1m0s
[08:49:11.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:46:0)
[08:49:11.474] Timer tick, asking Buildbucket for the build status
[08:49:11.602] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:11.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:47:0) after 1m0s
[08:50:11.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:47:0)
[08:50:11.638] Timer tick, asking Buildbucket for the build status
[08:50:11.735] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:11.735] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:48:0) after 1m0s
[08:51:11.780] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:48:0)
[08:51:11.780] Timer tick, asking Buildbucket for the build status
[08:51:12.258] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:12.258] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:49:0) after 1m0s
[08:52:12.399] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:49:0)
[08:52:12.399] Timer tick, asking Buildbucket for the build status
[08:52:12.514] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:12.514] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:50:0) after 1m0s
[08:53:12.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:50:0)
[08:53:12.629] Timer tick, asking Buildbucket for the build status
[08:53:12.685] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:12.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:51:0) after 1m0s
[08:54:12.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:51:0)
[08:54:12.743] Timer tick, asking Buildbucket for the build status
[08:54:12.895] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:12.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:52:0) after 1m0s
[08:55:12.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:52:0)
[08:55:12.917] Timer tick, asking Buildbucket for the build status
[08:55:13.216] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:13.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:53:0) after 1m0s
[08:56:13.256] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:53:0)
[08:56:13.256] Timer tick, asking Buildbucket for the build status
[08:56:13.310] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:13.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:54:0) after 1m0s
[08:57:13.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:54:0)
[08:57:13.481] Timer tick, asking Buildbucket for the build status
[08:57:13.576] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:13.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:55:0) after 1m0s
[08:58:13.713] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:55:0)
[08:58:13.713] Timer tick, asking Buildbucket for the build status
[08:58:14.096] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:14.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:56:0) after 1m0s
[08:59:14.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:56:0)
[08:59:14.281] Timer tick, asking Buildbucket for the build status
[08:59:14.343] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:14.343] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:57:0) after 1m0s
[09:00:14.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:57:0)
[09:00:14.514] Timer tick, asking Buildbucket for the build status
[09:00:15.155] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:15.155] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:58:0) after 1m0s
[09:01:15.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:58:0)
[09:01:15.224] Timer tick, asking Buildbucket for the build status
[09:01:15.401] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:15.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:59:0) after 1m0s
[09:02:15.391] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:59:0)
[09:02:15.391] Timer tick, asking Buildbucket for the build status
[09:02:15.458] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:15.458] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:60:0) after 1m0s
[09:03:15.475] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:60:0)
[09:03:15.475] Timer tick, asking Buildbucket for the build status
[09:03:15.542] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:15.542] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:61:0) after 1m0s
[09:04:15.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:61:0)
[09:04:15.547] Timer tick, asking Buildbucket for the build status
[09:04:15.734] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:15.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:62:0) after 1m0s
[09:05:15.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:62:0)
[09:05:15.744] Timer tick, asking Buildbucket for the build status
[09:05:15.839] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:15.839] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:63:0) after 1m0s
[09:06:15.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:63:0)
[09:06:15.873] Timer tick, asking Buildbucket for the build status
[09:06:16.006] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:16.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:64:0) after 1m0s
[09:07:16.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:64:0)
[09:07:16.477] Timer tick, asking Buildbucket for the build status
[09:07:16.705] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:16.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:65:0) after 1m0s
[09:08:16.813] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:65:0)
[09:08:16.813] Timer tick, asking Buildbucket for the build status
[09:08:16.901] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:16.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:66:0) after 1m0s
[09:09:16.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:66:0)
[09:09:16.928] Timer tick, asking Buildbucket for the build status
[09:09:17.088] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:17.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:67:0) after 1m0s
[09:10:17.171] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:67:0)
[09:10:17.171] Timer tick, asking Buildbucket for the build status
[09:10:17.322] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:17.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:68:0) after 1m0s
[09:11:17.356] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:68:0)
[09:11:17.356] Timer tick, asking Buildbucket for the build status
[09:11:17.485] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:17.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:69:0) after 1m0s
[09:12:17.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:69:0)
[09:12:17.573] Timer tick, asking Buildbucket for the build status
[09:12:17.732] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:17.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:70:0) after 1m0s
[09:13:17.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:70:0)
[09:13:17.872] Timer tick, asking Buildbucket for the build status
[09:13:17.943] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:17.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:71:0) after 1m0s
[09:14:18.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:71:0)
[09:14:18.125] Timer tick, asking Buildbucket for the build status
[09:14:18.182] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:18.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:72:0) after 1m0s
[09:15:18.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:72:0)
[09:15:18.455] Timer tick, asking Buildbucket for the build status
[09:15:18.592] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:18.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:73:0) after 1m0s
[09:16:18.788] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:73:0)
[09:16:18.788] Timer tick, asking Buildbucket for the build status
[09:16:18.851] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:18.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:74:0) after 1m0s
[09:17:19.088] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:74:0)
[09:17:19.088] Timer tick, asking Buildbucket for the build status
[09:17:19.151] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:19.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:75:0) after 1m0s
[09:18:19.419] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:75:0)
[09:18:19.419] Timer tick, asking Buildbucket for the build status
[09:18:19.492] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:19.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:76:0) after 1m0s
[09:19:19.661] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:76:0)
[09:19:19.661] Timer tick, asking Buildbucket for the build status
[09:19:19.716] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:19.716] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:77:0) after 1m0s
[09:20:19.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:77:0)
[09:20:19.844] Timer tick, asking Buildbucket for the build status
[09:20:19.932] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:19.932] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:78:0) after 1m0s
[09:21:19.973] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:78:0)
[09:21:19.973] Timer tick, asking Buildbucket for the build status
[09:21:20.044] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:20.044] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:79:0) after 1m0s
[09:22:20.102] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:79:0)
[09:22:20.102] Timer tick, asking Buildbucket for the build status
[09:22:20.153] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:20.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:80:0) after 1m0s
[09:23:20.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:80:0)
[09:23:20.228] Timer tick, asking Buildbucket for the build status
[09:23:20.291] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:20.291] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:81:0) after 1m0s
[09:24:20.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:81:0)
[09:24:20.307] Timer tick, asking Buildbucket for the build status
[09:24:20.374] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:20.374] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:82:0) after 1m0s
[09:25:20.635] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:82:0)
[09:25:20.635] Timer tick, asking Buildbucket for the build status
[09:25:20.728] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:20.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:83:0) after 1m0s
[09:26:20.752] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:83:0)
[09:26:20.752] Timer tick, asking Buildbucket for the build status
[09:26:21.139] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:21.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:84:0) after 1m0s
[09:27:21.301] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:84:0)
[09:27:21.301] Timer tick, asking Buildbucket for the build status
[09:27:21.352] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:21.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:85:0) after 1m0s
[09:28:21.383] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:85:0)
[09:28:21.383] Timer tick, asking Buildbucket for the build status
[09:28:21.601] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:21.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:86:0) after 1m0s
[09:29:21.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:86:0)
[09:29:21.626] Timer tick, asking Buildbucket for the build status
[09:29:21.687] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:21.687] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:87:0) after 1m0s
[09:30:21.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:87:0)
[09:30:21.722] Timer tick, asking Buildbucket for the build status
[09:30:21.807] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:21.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:88:0) after 1m0s
[09:31:21.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:88:0)
[09:31:21.885] Timer tick, asking Buildbucket for the build status
[09:31:21.996] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:21.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:89:0) after 1m0s
[09:32:22.091] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:89:0)
[09:32:22.091] Timer tick, asking Buildbucket for the build status
[09:32:22.503] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:22.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:90:0) after 1m0s
[09:33:22.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:90:0)
[09:33:22.528] Timer tick, asking Buildbucket for the build status
[09:33:22.663] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:22.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:91:0) after 1m0s
[09:34:22.688] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:91:0)
[09:34:22.688] Timer tick, asking Buildbucket for the build status
[09:34:22.742] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:22.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:92:0) after 1m0s
[09:35:22.956] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:92:0)
[09:35:22.956] Timer tick, asking Buildbucket for the build status
[09:35:23.041] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:23.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:93:0) after 1m0s
[09:36:23.100] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:93:0)
[09:36:23.100] Timer tick, asking Buildbucket for the build status
[09:36:23.154] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:23.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:94:0) after 1m0s
[09:37:23.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:94:0)
[09:37:23.307] Timer tick, asking Buildbucket for the build status
[09:37:23.426] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:23.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:95:0) after 1m0s
[09:38:23.457] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:95:0)
[09:38:23.457] Timer tick, asking Buildbucket for the build status
[09:38:23.520] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:23.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:96:0) after 1m0s
[09:39:23.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:96:0)
[09:39:23.542] Timer tick, asking Buildbucket for the build status
[09:39:23.617] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:23.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:97:0) after 1m0s
[09:40:23.746] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:97:0)
[09:40:23.746] Timer tick, asking Buildbucket for the build status
[09:40:24.014] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:24.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:98:0) after 1m0s
[09:41:24.040] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:98:0)
[09:41:24.040] Timer tick, asking Buildbucket for the build status
[09:41:24.115] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:24.115] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:99:0) after 1m0s
[09:42:24.150] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:99:0)
[09:42:24.150] Timer tick, asking Buildbucket for the build status
[09:42:24.231] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:24.231] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:100:0) after 1m0s
[09:43:24.223] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:100:0)
[09:43:24.223] Timer tick, asking Buildbucket for the build status
[09:43:24.496] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:24.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:101:0) after 1m0s
[09:44:24.625] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:101:0)
[09:44:24.625] Timer tick, asking Buildbucket for the build status
[09:44:24.727] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:24.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:102:0) after 1m0s
[09:45:24.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:102:0)
[09:45:24.782] Timer tick, asking Buildbucket for the build status
[09:45:24.867] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:24.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:103:0) after 1m0s
[09:46:24.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:103:0)
[09:46:24.974] Timer tick, asking Buildbucket for the build status
[09:46:25.145] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:25.145] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:104:0) after 1m0s
[09:47:25.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:104:0)
[09:47:25.205] Timer tick, asking Buildbucket for the build status
[09:47:25.270] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:25.270] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:105:0) after 1m0s
[09:48:25.255] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:105:0)
[09:48:25.255] Timer tick, asking Buildbucket for the build status
[09:48:25.504] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:25.504] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:106:0) after 1m0s
[09:49:25.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:106:0)
[09:49:25.528] Timer tick, asking Buildbucket for the build status
[09:49:25.597] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:25.597] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:107:0) after 1m0s
[09:50:25.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:107:0)
[09:50:25.664] Timer tick, asking Buildbucket for the build status
[09:50:25.981] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:25.981] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:108:0) after 1m0s
[09:51:25.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:108:0)
[09:51:25.963] Timer tick, asking Buildbucket for the build status
[09:51:26.047] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:26.047] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:109:0) after 1m0s
[09:52:26.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:109:0)
[09:52:26.124] Timer tick, asking Buildbucket for the build status
[09:52:26.242] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:26.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:110:0) after 1m0s
[09:53:26.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:110:0)
[09:53:26.269] Timer tick, asking Buildbucket for the build status
[09:53:26.332] Build 8860410077374149904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:26.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025840139555763872:111:0) after 1m0s
[09:53:37.202] Received PubSub notification, asking Buildbucket for the build status
[09:53:37.264] Build 8860410077374149904: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:53:37.264] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608458016733116",
"created_by": "project:chromium",
"created_ts": "1608451498589421",
"id": "8860410077374149904",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cfcbc37819fdd0337d9232bf75b85a752793b4ce\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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\": \"cfcbc37819fdd0337d9232bf75b85a752793b4ce\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-9-jqa2\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178837, \"got_angle_revision\": \"ed9213bca0643edb65b7d39a938210419398a1b3\", \"got_dawn_revision\": \"5d4fd88a7403aa255d49919d011af54c691b344a\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"cfcbc37819fdd0337d9232bf75b85a752793b4ce\", \"got_revision_cp\": \"refs/heads/master@{#838551}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"73bf5d7db9ade92643424d79b47ac70900843225\", \"got_v8_revision_cp\": \"refs/heads/8.9.178@{#1}\", \"got_webrtc_revision\": \"ef9c4e07a351c9396c72e72efaa1be3df728c440\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32863}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cfcbc37819fdd0337d9232bf75b85a752793b4ce\", \"swarm_hashes_refs/heads/master(at){#838551}_without_patch\": {\"absl_hardening_tests\": \"8f375d384e5b8a2ebdecc24bca0624147a11a2f1\", \"accessibility_unittests\": \"05cdfc98837fe8719fd4b89090dae2a2b99f510b\", \"angle_unittests\": \"6291cbe995b57c402b427dcd62f8f6abc7b60ab2\", \"app_shell_unittests\": \"02c6b7cfad364b2ca0e85933a459a3197410ffd5\", \"aura_unittests\": \"ece65af8897fade23a1e4f7fdece6de65edbfcb7\", \"base_unittests\": \"d707ed28b15b976451dca9fc89e14bff4ab070bc\", \"base_util_unittests\": \"84b03bad7f08af7e4c9c18e185422390f121e9d4\", \"blink_common_unittests\": \"0fb4539ff60dfda7b0c0d357c26adcd87626c096\", \"blink_fuzzer_unittests\": \"6dc3b2ee81f6a700162b1f3f33be3b84681a0b7d\", \"blink_heap_unittests\": \"e5c27216bc4ee19e33dd61fbe1504cef9b89d8bb\", \"blink_platform_unittests\": \"205a8da55a1905853217bfe4101a348c73d0fbbc\", \"blink_python_tests\": \"a850068bffdc4a670df6ad15aeda052beec9a023\", \"blink_unittests\": \"d52a54c967ca9141eb344dcd1a46c3042d434afb\", \"blink_web_tests\": \"7e79245417fc6a178c21c16b0e5832c883cbf95a\", \"boringssl_crypto_tests\": \"339c2652771d7b3e164a30240cc807aad06fc5f2\", \"boringssl_ssl_tests\": \"4125b55d8cb2aefef23667153037cfe9fe874c0e\", \"browser_tests\": \"f5d83a2b6d44db302041bdca41aa75132f33d1b7\", \"capture_unittests\": \"b6086e07ea995eed4030700d065abd4a2eaa0fa2\", \"cast_unittests\": \"cbb38d0211ab9276c59f0c5288c161615136333b\", \"cc_unittests\": \"ad6418234c6b1b5c1b18bdcba8a2eaf5182617d0\", \"chrome_app_unittests\": \"98d0d6e736641205d0e70f4f0ca295ac4bdcae08\", \"chromedriver_unittests\": \"ad38d2909ecad84f9ed1bc15ed319e472a5f15d5\", \"components_browsertests\": \"512101c8c04968d7fbb6fb48dce2db6994651a67\", \"components_unittests\": \"0dc4f1fef35ba78cae5bfa170fcd7e5255fa738d\", \"compositor_unittests\": \"3e153d166a333d9fe3d4fca33ee3716aa7a97217\", \"content_browsertests\": \"293dda42cdc47b1e397ca90bdd0bde88b7df259d\", \"content_shell_crash_test\": \"4c84d3b2b7c9ef1d2e6faf343761fd48b4d28c38\", \"content_unittests\": \"62c963a482b9a55bbaa6563b1a80b38c685b94d2\", \"crashpad_tests\": \"49f3237b435657bd0a41708c953bbb6e2282e049\", \"cronet_tests\": \"7ed8027278d9a58de868f6e799f05442cf33fe96\", \"cronet_unittests\": \"d6a67615f321d41768ab8feddef8bfb5b104f1c3\", \"crypto_unittests\": \"b4ea65d67dbc4046191211f280ea3161f64e3024\", \"dbus_unittests\": \"97b1705f3871e03b4dd6c1be2b4fd003b75ee19e\", \"device_unittests\": \"fd2027ef486ba12b9894662796832bbd42fafc62\", \"display_unittests\": \"30ea1167650ed5e6f7c5beecb9d9e0a1c15c0651\", \"events_unittests\": \"3cb2c037b0840a53281ea51f0c30735fe4ffa862\", \"extension_docserver_python_unittests\": \"71bcd6b7573d94ae1247016c00563f0ec7b193dc\", \"extensions_browsertests\": \"9ae9a7287dc3ac2972c49bb3bf21c2acd8445560\", \"extensions_unittests\": \"763e737a572ff14b51b69a0ecbdc51077b3912b3\", \"filesystem_service_unittests\": \"4632ffde0c6a59af291c8a56c844dd05e4d91d91\", \"flatbuffers_unittests\": \"d051d66da1ab229778a7e9a8f6ace686eaf5e782\", \"gcm_unit_tests\": \"44cee56f7056612bc9ee44a0bf38202b1d5df6ce\", \"gfx_unittests\": \"2b9dcbb014042f879d96752e4e64a85a8afd6d11\", \"gin_unittests\": \"ccd7f443fbe1a6e43fbd10fac29c04f63e129718\", \"google_apis_unittests\": \"51bf36ca78bc06d816b9b251bf51fe25578fad4f\", \"gpu_unittests\": \"b88bddf6665529ea7ef75969fb392a7ff90b28eb\", \"grit_python_unittests\": \"275c161e38b800af0a18bf8ee2ae20e83dfa4ea2\", \"gwp_asan_unittests\": \"85a4409656e25530c6e025787387b24b69465007\", \"headless_browsertests\": \"24bb1d14a5deb62e168dc20700a84589ec9ac69f\", \"headless_unittests\": \"18e799e9f9b891432d4c4a531589defb47597d18\", \"interactive_ui_tests\": \"b0b180acdf009ed9f2926c0b2bd027041b168230\", \"ipc_tests\": \"a153841652fbf6e22b05d3e0677f03196305c049\", \"jingle_unittests\": \"c66546048253e06ea9f761619df9ab26f59416c4\", \"latency_unittests\": \"dce1126157f68b150a2eb22ee4fa2ef0f0a97f8d\", \"libjingle_xmpp_unittests\": \"892a002b30cf1f12b3008fdc93270d3bedfc9e06\", \"liburlpattern_unittests\": \"2474b765488b21a51c6bda6602ca1fc506c1de64\", \"media_blink_unittests\": \"5db9d160f867ea985e3076da862ee0f4a9a14949\", \"media_unittests\": \"171893815d75a4309a2ab8ae60e86f0c4c73cec7\", \"message_center_unittests\": \"4ece78228f77b3eea83ce86bd0dc560fb4ce135b\", \"metrics_python_tests\": \"9a057f240d8e448aea1f99ca8cd2be4817085334\", \"midi_unittests\": \"0e00a73f893ed5495cd5f80993ab53d89adbcad8\", \"mojo_core_unittests\": \"abb7d61cbf24e8c91d09191c5de588526a852443\", \"mojo_unittests\": \"67c3963c7308806fb02c9fccc0fab10acfdc8eba\", \"nacl_helper_nonsfi_unittests\": \"504b27c5496dae8f718aa86efc3942da9cd9266e\", \"nacl_loader_unittests\": \"9c2fa3c8fe6167c75817175d4e072c15d245c5d9\", \"native_theme_unittests\": \"4370d4c261fe25c03d4e4d30d76f3a4f33e0716e\", \"net_unittests\": \"ed63b978e2b48113613bbefe2bcd473d2b071a8e\", \"openscreen_unittests\": \"ea46e1452c41efe34203e0db47631a281998bd81\", \"pdf_unittests\": \"5aa127a2d37f6fede824858ec9d3d9579f125a26\", \"perfetto_unittests\": \"2b4794f2711a3c606bb1b5db4b17b4c5bc51e90d\", \"ppapi_unittests\": \"34fdb52a7fb70fc2a97b230b9279ae2e849aae58\", \"printing_unittests\": \"2f2252e03d70b8f687fb79df98939ed8de63dbf5\", \"remoting_unittests\": \"8341f86961338186ee4e0b375238c87be49002a2\", \"sandbox_linux_unittests\": \"7b6c06a037257977d5ce0d7d5edadaef9eb97a47\", \"service_manager_unittests\": \"bda8e7d9dd81a88bf35a1ee16450118dc4ffcfc8\", \"services_unittests\": \"92f75740acd35b9f6a20a37d21f2b29aad5ccc5b\", \"shell_dialogs_unittests\": \"e2bb0d9ec4e780280f0a6ed6d519f9da5693911a\", \"skia_unittests\": \"4ad79d977d3fbdaa81120a51e9ab1b7addb58100\", \"snapshot_unittests\": \"383876e03c4fa21fbc34e22d5661362812f62ea8\", \"sql_unittests\": \"29d5e2732b97881338fedde8246ed0f24f84b4b7\", \"storage_unittests\": \"e055b3e65cd4635de7f4e8672e92c266fae3d7c4\", \"sync_integration_tests\": \"f89bbfe5fff111a41bb4e9ead196348779956769\", \"telemetry_gpu_unittests\": \"72e49f1d6f8f2162e1e79a624e9ce46fee20ad43\", \"telemetry_perf_unittests\": \"72b609b6bb942fb255dd39cbf74a501e5395fa24\", \"telemetry_unittests\": \"3252f218fc917403e50e3b39e3af059eb3fd3fd7\", \"traffic_annotation_auditor_unittests\": \"5bc4e70c9e0e0b966adfbe4b674eb7999682a513\", \"ui_base_unittests\": \"e54cd8fac54613ffa5412088feb0bd069d35b867\", \"ui_touch_selection_unittests\": \"c0579655b924c159a29bc7db769723a2188c9685\", \"unit_tests\": \"5cd4cb765bfa380224eb734f4819b9b970dfc5bf\", \"url_unittests\": \"eb4a65202e14902b6a6c737a6a15ba5786375147\", \"views_perftests\": \"b21e0b8443265442567bd53cb75542bec4558c40\", \"views_unittests\": \"215dbb99de85144c0390814606646574df99414f\", \"viz_unittests\": \"d088b29eb268c4a106a69ef5fd4832e6e6fb7f3f\", \"vr_common_unittests\": \"1341c0013d4c3dbb9bb6a0d6c9a6a255540f4e87\", \"vr_pixeltests\": \"4265a62d3c1e8c9f633107b02cee45e514d73109\", \"webdriver_wpt_tests\": \"2d0e3f289f2b6c17f8cb5c26bed0c1f06f13ec24\", \"weblayer_browsertests\": \"5fe2af5061d3e044be54a8cb23acf8e485ae8e28\", \"weblayer_unittests\": \"d4cd5b4b3f7b052aa4b531aa72030218f4b5ec30\", \"wm_unittests\": \"ea5761e0dc3e4e5c07856056e92a04abe6068ee2\", \"wtf_unittests\": \"cc735385c459e43fa397309432ce06c7b744d3fb\", \"x11_unittests\": \"72642615448c8e7f4cdba628dae26ace4d89c41e\", \"xr_browser_tests\": \"a0be6f77ee1fd73ed2bfab7766b7a0c5baa58398\", \"zlib_unittests\": \"d7b4949fd0c0340e972b0ab41b48f91449fbaa72\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_321a2ce955953920551fc69856a295b9c48a1a2350c0055b827d09f10d75e261_v2\", \"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_5f9879dd307b3e3de87d4273aaf77dfc3adf50a63c1d75c3b245bfdff463a933_v2\", \"builder_7a9f94695aa83f7478015e01762e75301e67c95c681ec0592232bd343861e191_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-9-jqa2\"], \"image\": [\"chrome-xenial-20121300-d43316a0aad\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608453635515797",
"status": "COMPLETED",
"status_changed_ts": "1608458016966845",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178837",
"builder:Linux Builder (dbg)",
"buildset:commit/git/cfcbc37819fdd0337d9232bf75b85a752793b4ce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cfcbc37819fdd0337d9232bf75b85a752793b4ce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025840139555763872",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8860410077374149904/+/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:5097ffaf249d0c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1608458016971620",
"url": "https://ci.chromium.org/b/8860410077374149904",
"utcnow_ts": "1608458017256459"
}
}
[09:53:37.264] Invocation finished in 1h48m40.13959858s with status SUCCEEDED