[19:47:57.907] New invocation is queued and will start shortly
[19:47:59.211] Starting the invocation (attempt 1)
[19:47:59.243] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:47:59.243] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:47:59.243] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023259194758342208",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"66b48e783de0b7944bd9f36bdae1bf60c7b51e0d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9023259194758342208",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/66b48e783de0b7944bd9f36bdae1bf60c7b51e0d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/66b48e783de0b7944bd9f36bdae1bf60c7b51e0d",
"gitiles_ref:refs/heads/master"
]
}
[19:48:00.212] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610912879360512",
"id": "8857829132570248672",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"66b48e783de0b7944bd9f36bdae1bf60c7b51e0d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610912880095482",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179716",
"builder:Linux Builder (dbg)",
"buildset:commit/git/66b48e783de0b7944bd9f36bdae1bf60c7b51e0d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/66b48e783de0b7944bd9f36bdae1bf60c7b51e0d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023259194758342208",
"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/8857829132570248672/+/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": "1610912880095634",
"url": "https://ci.chromium.org/b/8857829132570248672",
"utcnow_ts": "1610912880205480"
}
}
[19:48:00.212] Task URL: https://ci.chromium.org/b/8857829132570248672
[19:48:00.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:2:0) after 1m0s
[19:49:00.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:2:0)
[19:49:00.268] Timer tick, asking Buildbucket for the build status
[19:49:00.562] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:00.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:3:0) after 1m0s
[19:50:00.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:3:0)
[19:50:00.551] Timer tick, asking Buildbucket for the build status
[19:50:00.650] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:50:00.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:4:0) after 1m0s
[19:51:00.670] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:4:0)
[19:51:00.670] Timer tick, asking Buildbucket for the build status
[19:51:00.744] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:51:00.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:5:0) after 1m0s
[19:52:00.764] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:5:0)
[19:52:00.764] Timer tick, asking Buildbucket for the build status
[19:52:00.877] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:00.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:6:0) after 1m0s
[19:53:02.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:6:0)
[19:53:02.542] Timer tick, asking Buildbucket for the build status
[19:53:02.701] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:02.701] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:7:0) after 1m0s
[19:54:03.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:7:0)
[19:54:03.095] Timer tick, asking Buildbucket for the build status
[19:54:03.444] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:03.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:8:0) after 1m0s
[19:55:03.648] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:8:0)
[19:55:03.648] Timer tick, asking Buildbucket for the build status
[19:55:03.736] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:03.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:9:0) after 1m0s
[19:56:03.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:9:0)
[19:56:03.935] Timer tick, asking Buildbucket for the build status
[19:56:04.023] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:56:04.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:10:0) after 1m0s
[19:57:04.146] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:10:0)
[19:57:04.146] Timer tick, asking Buildbucket for the build status
[19:57:04.318] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:04.318] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:11:0) after 1m0s
[19:58:04.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:11:0)
[19:58:04.338] Timer tick, asking Buildbucket for the build status
[19:58:04.523] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:58:04.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:12:0) after 1m0s
[19:59:04.557] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:12:0)
[19:59:04.557] Timer tick, asking Buildbucket for the build status
[19:59:04.631] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:04.631] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:13:0) after 1m0s
[20:00:04.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:13:0)
[20:00:04.732] Timer tick, asking Buildbucket for the build status
[20:00:05.009] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:05.009] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:14:0) after 1m0s
[20:01:05.255] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:14:0)
[20:01:05.255] Timer tick, asking Buildbucket for the build status
[20:01:05.470] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:05.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:15:0) after 1m0s
[20:02:05.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:15:0)
[20:02:05.589] Timer tick, asking Buildbucket for the build status
[20:02:05.654] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:05.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:16:0) after 1m0s
[20:03:05.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:16:0)
[20:03:05.682] Timer tick, asking Buildbucket for the build status
[20:03:06.258] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:03:06.258] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:17:0) after 1m0s
[20:04:06.306] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:17:0)
[20:04:06.306] Timer tick, asking Buildbucket for the build status
[20:04:06.589] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:04:06.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:18:0) after 1m0s
[20:05:06.614] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:18:0)
[20:05:06.614] Timer tick, asking Buildbucket for the build status
[20:05:06.828] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:05:06.828] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:19:0) after 1m0s
[20:06:06.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:19:0)
[20:06:06.889] Timer tick, asking Buildbucket for the build status
[20:06:06.973] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:06:06.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:20:0) after 1m0s
[20:07:07.100] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:20:0)
[20:07:07.100] Timer tick, asking Buildbucket for the build status
[20:07:07.188] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:07.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:21:0) after 1m0s
[20:08:07.254] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:21:0)
[20:08:07.254] Timer tick, asking Buildbucket for the build status
[20:08:07.354] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:07.354] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:22:0) after 1m0s
[20:09:07.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:22:0)
[20:09:07.409] Timer tick, asking Buildbucket for the build status
[20:09:07.728] Build 8857829132570248672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:07.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:23:0) after 1m0s
[20:09:35.941] Received PubSub notification, asking Buildbucket for the build status
[20:09:36.194] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:07.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:23:0)
[20:10:07.748] Timer tick, asking Buildbucket for the build status
[20:10:08.418] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:08.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:25:0) after 1m0s
[20:11:08.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:25:0)
[20:11:08.488] Timer tick, asking Buildbucket for the build status
[20:11:08.793] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:08.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:26:0) after 1m0s
[20:12:08.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:26:0)
[20:12:08.851] Timer tick, asking Buildbucket for the build status
[20:12:08.941] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:08.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:27:0) after 1m0s
[20:13:08.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:27:0)
[20:13:08.930] Timer tick, asking Buildbucket for the build status
[20:13:09.298] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:09.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:28:0) after 1m0s
[20:14:09.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:28:0)
[20:14:09.318] Timer tick, asking Buildbucket for the build status
[20:14:09.534] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:09.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:29:0) after 1m0s
[20:15:09.554] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:29:0)
[20:15:09.554] Timer tick, asking Buildbucket for the build status
[20:15:09.628] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:09.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:30:0) after 1m0s
[20:16:09.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:30:0)
[20:16:09.674] Timer tick, asking Buildbucket for the build status
[20:16:10.152] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:10.152] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:31:0) after 1m0s
[20:17:10.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:31:0)
[20:17:10.244] Timer tick, asking Buildbucket for the build status
[20:17:10.339] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:10.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:32:0) after 1m0s
[20:18:10.365] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:32:0)
[20:18:10.365] Timer tick, asking Buildbucket for the build status
[20:18:10.737] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:10.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:33:0) after 1m0s
[20:19:10.758] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:33:0)
[20:19:10.758] Timer tick, asking Buildbucket for the build status
[20:19:10.829] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:10.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:34:0) after 1m0s
[20:20:10.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:34:0)
[20:20:10.852] Timer tick, asking Buildbucket for the build status
[20:20:11.045] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:11.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:35:0) after 1m0s
[20:21:11.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:35:0)
[20:21:11.323] Timer tick, asking Buildbucket for the build status
[20:21:11.603] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:11.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:36:0) after 1m0s
[20:22:11.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:36:0)
[20:22:11.740] Timer tick, asking Buildbucket for the build status
[20:22:12.032] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:12.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:37:0) after 1m0s
[20:23:12.139] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:37:0)
[20:23:12.139] Timer tick, asking Buildbucket for the build status
[20:23:12.398] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:12.398] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:38:0) after 1m0s
[20:24:12.582] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:38:0)
[20:24:12.582] Timer tick, asking Buildbucket for the build status
[20:24:13.031] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:13.031] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:39:0) after 1m0s
[20:25:13.018] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:39:0)
[20:25:13.018] Timer tick, asking Buildbucket for the build status
[20:25:13.083] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:13.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:40:0) after 1m0s
[20:26:13.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:40:0)
[20:26:13.066] Timer tick, asking Buildbucket for the build status
[20:26:13.131] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:13.131] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:41:0) after 1m0s
[20:27:13.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:41:0)
[20:27:13.321] Timer tick, asking Buildbucket for the build status
[20:27:13.393] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:13.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:42:0) after 1m0s
[20:28:13.443] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:42:0)
[20:28:13.443] Timer tick, asking Buildbucket for the build status
[20:28:13.727] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:13.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:43:0) after 1m0s
[20:29:13.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:43:0)
[20:29:13.796] Timer tick, asking Buildbucket for the build status
[20:29:13.856] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:13.856] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:44:0) after 1m0s
[20:30:13.880] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:44:0)
[20:30:13.880] Timer tick, asking Buildbucket for the build status
[20:30:14.285] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:14.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:45:0) after 1m0s
[20:31:14.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:45:0)
[20:31:14.441] Timer tick, asking Buildbucket for the build status
[20:31:14.559] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:14.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:46:0) after 1m0s
[20:32:14.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:46:0)
[20:32:14.624] Timer tick, asking Buildbucket for the build status
[20:32:14.689] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:14.689] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:47:0) after 1m0s
[20:33:14.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:47:0)
[20:33:14.848] Timer tick, asking Buildbucket for the build status
[20:33:15.007] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:15.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:48:0) after 1m0s
[20:34:15.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:48:0)
[20:34:15.166] Timer tick, asking Buildbucket for the build status
[20:34:15.501] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:15.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:49:0) after 1m0s
[20:35:15.611] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:49:0)
[20:35:15.611] Timer tick, asking Buildbucket for the build status
[20:35:15.684] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:15.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:50:0) after 1m0s
[20:36:15.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:50:0)
[20:36:15.722] Timer tick, asking Buildbucket for the build status
[20:36:15.772] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:15.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:51:0) after 1m0s
[20:37:15.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:51:0)
[20:37:15.869] Timer tick, asking Buildbucket for the build status
[20:37:16.026] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:16.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:52:0) after 1m0s
[20:38:16.110] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:52:0)
[20:38:16.110] Timer tick, asking Buildbucket for the build status
[20:38:16.229] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:16.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:53:0) after 1m0s
[20:39:16.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:53:0)
[20:39:16.221] Timer tick, asking Buildbucket for the build status
[20:39:16.281] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:16.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:54:0) after 1m0s
[20:40:16.342] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:54:0)
[20:40:16.342] Timer tick, asking Buildbucket for the build status
[20:40:16.663] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:16.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:55:0) after 1m0s
[20:41:16.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:55:0)
[20:41:16.682] Timer tick, asking Buildbucket for the build status
[20:41:16.736] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:16.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:56:0) after 1m0s
[20:42:16.762] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:56:0)
[20:42:16.762] Timer tick, asking Buildbucket for the build status
[20:42:16.833] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:16.833] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:57:0) after 1m0s
[20:43:16.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:57:0)
[20:43:16.856] Timer tick, asking Buildbucket for the build status
[20:43:16.975] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:16.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:58:0) after 1m0s
[20:44:16.998] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:58:0)
[20:44:16.998] Timer tick, asking Buildbucket for the build status
[20:44:17.063] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:17.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:59:0) after 1m0s
[20:45:17.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:59:0)
[20:45:17.101] Timer tick, asking Buildbucket for the build status
[20:45:17.185] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:17.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:60:0) after 1m0s
[20:46:17.248] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:60:0)
[20:46:17.248] Timer tick, asking Buildbucket for the build status
[20:46:17.392] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:17.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:61:0) after 1m0s
[20:47:17.592] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:61:0)
[20:47:17.592] Timer tick, asking Buildbucket for the build status
[20:47:17.656] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:17.656] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:62:0) after 1m0s
[20:48:17.761] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:62:0)
[20:48:17.761] Timer tick, asking Buildbucket for the build status
[20:48:17.856] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:17.856] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:63:0) after 1m0s
[20:49:17.906] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:63:0)
[20:49:17.906] Timer tick, asking Buildbucket for the build status
[20:49:17.970] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:17.970] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:64:0) after 1m0s
[20:50:18.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:64:0)
[20:50:18.095] Timer tick, asking Buildbucket for the build status
[20:50:18.359] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:18.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:65:0) after 1m0s
[20:51:18.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:65:0)
[20:51:18.436] Timer tick, asking Buildbucket for the build status
[20:51:18.493] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:18.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:66:0) after 1m0s
[20:52:18.539] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:66:0)
[20:52:18.539] Timer tick, asking Buildbucket for the build status
[20:52:18.604] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:18.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:67:0) after 1m0s
[20:53:18.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:67:0)
[20:53:18.628] Timer tick, asking Buildbucket for the build status
[20:53:18.841] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:18.841] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:68:0) after 1m0s
[20:54:18.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:68:0)
[20:54:18.869] Timer tick, asking Buildbucket for the build status
[20:54:18.939] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:18.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:69:0) after 1m0s
[20:55:18.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:69:0)
[20:55:18.956] Timer tick, asking Buildbucket for the build status
[20:55:19.302] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:19.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:70:0) after 1m0s
[20:56:19.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:70:0)
[20:56:19.424] Timer tick, asking Buildbucket for the build status
[20:56:19.633] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:19.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:71:0) after 1m0s
[20:57:19.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:71:0)
[20:57:19.721] Timer tick, asking Buildbucket for the build status
[20:57:19.850] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:19.850] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:72:0) after 1m0s
[20:58:19.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:72:0)
[20:58:19.871] Timer tick, asking Buildbucket for the build status
[20:58:19.977] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:19.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:73:0) after 1m0s
[20:59:20.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:73:0)
[20:59:20.000] Timer tick, asking Buildbucket for the build status
[20:59:20.272] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:20.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:74:0) after 1m0s
[21:00:20.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:74:0)
[21:00:20.329] Timer tick, asking Buildbucket for the build status
[21:00:20.417] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:20.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:75:0) after 1m0s
[21:01:20.440] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:75:0)
[21:01:20.440] Timer tick, asking Buildbucket for the build status
[21:01:20.501] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:20.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:76:0) after 1m0s
[21:02:20.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:76:0)
[21:02:20.591] Timer tick, asking Buildbucket for the build status
[21:02:20.778] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:20.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:77:0) after 1m0s
[21:03:20.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:77:0)
[21:03:20.807] Timer tick, asking Buildbucket for the build status
[21:03:21.307] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:21.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:78:0) after 1m0s
[21:04:21.335] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:78:0)
[21:04:21.335] Timer tick, asking Buildbucket for the build status
[21:04:21.771] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:21.771] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:79:0) after 1m0s
[21:05:21.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:79:0)
[21:05:21.875] Timer tick, asking Buildbucket for the build status
[21:05:21.955] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:21.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:80:0) after 1m0s
[21:06:22.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:80:0)
[21:06:22.028] Timer tick, asking Buildbucket for the build status
[21:06:22.099] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:22.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:81:0) after 1m0s
[21:07:22.091] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:81:0)
[21:07:22.091] Timer tick, asking Buildbucket for the build status
[21:07:22.324] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:22.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:82:0) after 1m0s
[21:08:22.384] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:82:0)
[21:08:22.384] Timer tick, asking Buildbucket for the build status
[21:08:22.634] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:22.635] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:83:0) after 1m0s
[21:09:22.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:83:0)
[21:09:22.716] Timer tick, asking Buildbucket for the build status
[21:09:22.811] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:22.811] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:84:0) after 1m0s
[21:10:22.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:84:0)
[21:10:22.917] Timer tick, asking Buildbucket for the build status
[21:10:22.976] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:22.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:85:0) after 1m0s
[21:11:23.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:85:0)
[21:11:23.032] Timer tick, asking Buildbucket for the build status
[21:11:23.125] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:23.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:86:0) after 1m0s
[21:12:23.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:86:0)
[21:12:23.105] Timer tick, asking Buildbucket for the build status
[21:12:23.172] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:23.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:87:0) after 1m0s
[21:13:23.196] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:87:0)
[21:13:23.196] Timer tick, asking Buildbucket for the build status
[21:13:23.310] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:23.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:88:0) after 1m0s
[21:14:23.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:88:0)
[21:14:23.318] Timer tick, asking Buildbucket for the build status
[21:14:23.392] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:23.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:89:0) after 1m0s
[21:15:23.419] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:89:0)
[21:15:23.419] Timer tick, asking Buildbucket for the build status
[21:15:23.493] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:23.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:90:0) after 1m0s
[21:16:23.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:90:0)
[21:16:23.522] Timer tick, asking Buildbucket for the build status
[21:16:23.894] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:23.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:91:0) after 1m0s
[21:17:25.649] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:91:0)
[21:17:25.649] Timer tick, asking Buildbucket for the build status
[21:17:25.725] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:25.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:92:0) after 1m0s
[21:18:25.769] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:92:0)
[21:18:25.769] Timer tick, asking Buildbucket for the build status
[21:18:25.861] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:25.861] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:93:0) after 1m0s
[21:19:25.883] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:93:0)
[21:19:25.883] Timer tick, asking Buildbucket for the build status
[21:19:26.152] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:26.152] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:94:0) after 1m0s
[21:20:26.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:94:0)
[21:20:26.136] Timer tick, asking Buildbucket for the build status
[21:20:26.393] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:26.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:95:0) after 1m0s
[21:21:26.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:95:0)
[21:21:26.593] Timer tick, asking Buildbucket for the build status
[21:21:26.691] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:26.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:96:0) after 1m0s
[21:22:26.750] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:96:0)
[21:22:26.750] Timer tick, asking Buildbucket for the build status
[21:22:26.977] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:26.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:97:0) after 1m0s
[21:23:27.011] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:97:0)
[21:23:27.011] Timer tick, asking Buildbucket for the build status
[21:23:27.630] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:27.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:98:0) after 1m0s
[21:24:27.657] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:98:0)
[21:24:27.657] Timer tick, asking Buildbucket for the build status
[21:24:28.180] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:28.180] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:99:0) after 1m0s
[21:25:28.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:99:0)
[21:25:28.283] Timer tick, asking Buildbucket for the build status
[21:25:28.462] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:28.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:100:0) after 1m0s
[21:26:28.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:100:0)
[21:26:28.484] Timer tick, asking Buildbucket for the build status
[21:26:28.576] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:28.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:101:0) after 1m0s
[21:27:28.584] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:101:0)
[21:27:28.584] Timer tick, asking Buildbucket for the build status
[21:27:28.724] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:28.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:102:0) after 1m0s
[21:28:28.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:102:0)
[21:28:28.782] Timer tick, asking Buildbucket for the build status
[21:28:29.399] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:29.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:103:0) after 1m0s
[21:29:29.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:103:0)
[21:29:29.423] Timer tick, asking Buildbucket for the build status
[21:29:29.482] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:29.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:104:0) after 1m0s
[21:30:29.502] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:104:0)
[21:30:29.502] Timer tick, asking Buildbucket for the build status
[21:30:29.569] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:29.569] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:105:0) after 1m0s
[21:31:29.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:105:0)
[21:31:29.578] Timer tick, asking Buildbucket for the build status
[21:31:29.646] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:29.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:106:0) after 1m0s
[21:32:29.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:106:0)
[21:32:29.706] Timer tick, asking Buildbucket for the build status
[21:32:30.120] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:30.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:107:0) after 1m0s
[21:33:30.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:107:0)
[21:33:30.157] Timer tick, asking Buildbucket for the build status
[21:33:30.253] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:30.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:108:0) after 1m0s
[21:34:30.279] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:108:0)
[21:34:30.279] Timer tick, asking Buildbucket for the build status
[21:34:30.390] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:30.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:109:0) after 1m0s
[21:35:30.383] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:109:0)
[21:35:30.383] Timer tick, asking Buildbucket for the build status
[21:35:31.433] Build 8857829132570248672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:31.433] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023259194758342208:110:0) after 1m0s
[21:36:22.859] Received PubSub notification, asking Buildbucket for the build status
[21:36:22.926] Build 8857829132570248672: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:36:22.926] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610919381785194",
"created_by": "project:chromium",
"created_ts": "1610912879360512",
"id": "8857829132570248672",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"66b48e783de0b7944bd9f36bdae1bf60c7b51e0d\"}}",
"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\": \"66b48e783de0b7944bd9f36bdae1bf60c7b51e0d\", \"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-58-w6bq\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 179716, \"got_angle_revision\": \"9f09435bc1921d4df8423211216570b6a4c29840\", \"got_dawn_revision\": \"04772515a8b613150b28bbed19b4c261e0b50e96\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"66b48e783de0b7944bd9f36bdae1bf60c7b51e0d\", \"got_revision_cp\": \"refs/heads/master@{#844400}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"149733cead636de93d96c5c64f30168d5f6bb03f\", \"got_v8_revision\": \"16b9bbbd581c25391981aa03180b76aa60463a3e\", \"got_v8_revision_cp\": \"refs/heads/8.9.255@{#1}\", \"got_webrtc_revision\": \"09729d2ecf49d256f6648494b59076b01786dc51\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33013}\", \"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\": \"66b48e783de0b7944bd9f36bdae1bf60c7b51e0d\", \"swarm_hashes_refs/heads/master(at){#844400}_without_patch\": {\"absl_hardening_tests\": \"8f1a53724ba5d3ad552b0115c2d77cad43ca6ad6\", \"accessibility_unittests\": \"6a29d0ae9a3aef869150c050b0bad8ee3563ea9d\", \"angle_unittests\": \"85528208718383fe91afd2472b1f11ee3eaef9f8\", \"app_shell_unittests\": \"6e53d390cf006efa895294cda8273d17e9b7d0a5\", \"aura_unittests\": \"faf7024559f56f60181b97338e40357a3267e42d\", \"base_unittests\": \"cc3e3955404ab915ec6c985644967b0a2da3e587\", \"base_util_unittests\": \"ab0ca8b249438e19566c14cc5969b85ba9d223ad\", \"blink_common_unittests\": \"b6acfdcd919380fef8ec46b60b5c05cdad14d10f\", \"blink_fuzzer_unittests\": \"80e25b20811aa605d3dbcdb5cbf12350f9f09984\", \"blink_heap_unittests\": \"99c20b10d3b9eeca7bc6f499912d4f9ce44a2a90\", \"blink_platform_unittests\": \"7261e1d19e0c49cade186e487551669bd276152d\", \"blink_python_tests\": \"b67453387a60642b66e3433dfe02c035cc89e2e7\", \"blink_unittests\": \"96a304cff4f133e4bdba085dbcac963a60453878\", \"blink_web_tests\": \"41a121c06f718e1775728a85572693e39f70ecd6\", \"boringssl_crypto_tests\": \"142c6624f90c4a1df7c7c8d1a4788cf5077e07d1\", \"boringssl_ssl_tests\": \"c86ad45d5181787e2001f480c58dc8fa31cd1f02\", \"browser_tests\": \"f8219cf1f3ec184728569fe2111cd204ad3ac5a9\", \"capture_unittests\": \"fe3efb7a1208e8faf5e515485025414086102376\", \"cast_unittests\": \"173936bc94ab6dad347bbacff3f653d4e6c8888d\", \"cc_unittests\": \"a1fff3f0d64b707aa0d7d1439ef361047fcf17a3\", \"chrome_app_unittests\": \"a457206275286194562b6b0b6d34f07c59c00e53\", \"chromedriver_unittests\": \"860bfbfce94cd5f53c2756e64e607329ccd527e3\", \"components_browsertests\": \"db5bd0e848200433039897807ee60d66eeee269d\", \"components_unittests\": \"8ae058cdce9503cc2cfde414fa2034025caa9340\", \"compositor_unittests\": \"9bf29b7d307afa1067ffbb25215ed1fbd386d2ac\", \"content_browsertests\": \"841907aa8bbc974520b3f0e34cbdd29342593b6a\", \"content_shell_crash_test\": \"ed30113bf81427743be6f6df9fb4360f6df031e4\", \"content_unittests\": \"eb6b52d2f053887ea6ad98c82b07625371fbff7b\", \"crashpad_tests\": \"8d209b1c1033eb7e9f5fc5bebbf3bb62a2139496\", \"cronet_tests\": \"f4bcafa41b543c03d7b6768f368f2f43a9843140\", \"cronet_unittests\": \"0a55ff5a144e2c74ae22b05cbd9b6bd8b51ffde6\", \"crypto_unittests\": \"f98e1cdd0eba960b10684244b4ceb1351e12dc63\", \"dbus_unittests\": \"45e3eb1272eb56b62e40bad818ac6e317f9934ff\", \"device_unittests\": \"89071a530746e488b84ffebb4e4c6bed76da9c64\", \"display_unittests\": \"32e758caba4fe6ef0b723022e7470bd41cefb613\", \"events_unittests\": \"aa490857515cf5d730b7b4f0053c65a19b6053d0\", \"extensions_browsertests\": \"f230f8ce2c1106f8701060a7b23aebf8756d49dd\", \"extensions_unittests\": \"cb04dc1be3f5f19495160358aaeb67c507e1876a\", \"filesystem_service_unittests\": \"aa58992af7d9376604c94273e22b8ab1c6c948d8\", \"flatbuffers_unittests\": \"25b512d24faefec22057a686bb0e2be1452a1abb\", \"gcm_unit_tests\": \"892e5c99d241347b5612b56295da25f35ca95b76\", \"gfx_unittests\": \"581001f1caaaa9fb6e0f9ef43e808821de4f8cd7\", \"gin_unittests\": \"6f40e88f8fd424ba9195709fa73f87b5c9a77809\", \"google_apis_unittests\": \"c975fc4d6418e2ea545826bf7e0b7e52c3264c01\", \"gpu_unittests\": \"03028bf185da52797fa78b2dbb3f9e5843652b54\", \"grit_python_unittests\": \"0b6d4d52edfdb860d49b4e2f566968b0e84ea187\", \"gwp_asan_unittests\": \"8321823b96eba152dc7b479fe217e27858b7b9e0\", \"headless_browsertests\": \"f9c9f13ff8cdbe54579bcf59c40d1dcd3d5fad3f\", \"headless_unittests\": \"cf0df314c74ca80d2901a9cbb58a24532e335284\", \"interactive_ui_tests\": \"439a4156ca0e9f78d10f919ebb5347d55d01ca01\", \"ipc_tests\": \"dd328741816708c551f1482fbcd90358d528055d\", \"jingle_unittests\": \"3cc42c181848bd20da6776c8832552e9d635dc72\", \"latency_unittests\": \"bde33bf8a19df7096e7c977f10ff99d2a38de7dc\", \"libjingle_xmpp_unittests\": \"bf69a42fc05784c10519b32d4e2bdcea9defde70\", \"liburlpattern_unittests\": \"36d0d10008141ceb36db3a1dc68cf56189210a60\", \"media_blink_unittests\": \"227f50692919843c0c6414acb9f836bf5928a419\", \"media_unittests\": \"56e85d99acbe52294666abb4bd6ecabe87827804\", \"message_center_unittests\": \"bc5c4689a61d7c717ea296fe53b5fe4ee93fa7ac\", \"metrics_python_tests\": \"dd997b8899d457711bdb36dac8eed5e418ffae7a\", \"midi_unittests\": \"82d123fb2c412d6f8232a17453bb8d8abfcf227d\", \"mojo_core_unittests\": \"2f41187af50f954e53492589a32a437f7e9e9a7d\", \"mojo_unittests\": \"a6f34e59c4042cddb912194c87342e2a4d154468\", \"nacl_helper_nonsfi_unittests\": \"288091be5887dd2855b3996e8a98ff7b97ca579a\", \"nacl_loader_unittests\": \"7e64894b091cc76a34638cd8e240d710fb929a18\", \"native_theme_unittests\": \"40cd4dd22f7fa92f4a749e1cf63ea9940c0c9d33\", \"net_unittests\": \"09cc96e1902baaf87ccb8852aeff5c5a8720eaf3\", \"openscreen_unittests\": \"1eb33ba7cf6fd97dd5be9a5dce692faed24075b1\", \"pdf_unittests\": \"282377889a1d9fce2d82cee5e4c6f163c240de39\", \"perfetto_unittests\": \"85611892048d387c28c4592eef735cac78897c7b\", \"ppapi_unittests\": \"7bc16bc8f01da328981efe431427e62e7b769eec\", \"printing_unittests\": \"568c7cc39f8c490a676f5554a714295d6382ee52\", \"remoting_unittests\": \"52ce095bf0cea2e690781b9aa1168cc5eef634b7\", \"sandbox_linux_unittests\": \"3be9d0ef346e3d2a94b27b71a82b89fb89dc4344\", \"service_manager_unittests\": \"d76276df284c6534b3a0e448be39d5123c3ce645\", \"services_unittests\": \"d5e73de3f91b52cf3eba2746924d31876fbc3e37\", \"shell_dialogs_unittests\": \"4c7d021971f32d3d030ec85ae2162aa2e994d717\", \"skia_unittests\": \"49cbeee5d921154e001346526ace0ff724264ad9\", \"snapshot_unittests\": \"f2ee1eda329a9b06ec17bfce34d5cde356d01bcd\", \"sql_unittests\": \"9e5b18a4f7baacbc8b6123ed1ab4c9e566ec1f39\", \"storage_unittests\": \"bdb06a4683f0a8d1f26c7caa733fe828b38231bc\", \"sync_integration_tests\": \"2fd4fb77d065f4166fa645fa207ffe2ef43cf3b7\", \"telemetry_gpu_unittests\": \"d6c45c4a728168651ab74c59ee90887db1746943\", \"telemetry_perf_unittests\": \"b9f1aa03051d2133b019dd58cc2cc3c7bb256261\", \"telemetry_unittests\": \"b63f7dd58e022d7c8edd8e151c18ef1ffee2431d\", \"traffic_annotation_auditor_unittests\": \"1dc70c8c0cde5c306b9d8cba5222c7309cc0db47\", \"ui_base_unittests\": \"cf71382b22233ca930f5221e75083da2a8f0e4f0\", \"ui_touch_selection_unittests\": \"7c6d2995769bf30d529439540c9ccef031ae5b5f\", \"unit_tests\": \"c775e5e081eedd18d60e4dec02d5d8029ca320b9\", \"url_unittests\": \"d0eaee52ab0996bb561871ccd0c6bf5bc0bf3918\", \"views_perftests\": \"4d3ffea768d0ff0402906532ef44075626872914\", \"views_unittests\": \"d038f671de83c48ed4f7494fbfa77f7a91954448\", \"viz_unittests\": \"9809f7516507e4587d13f77e60259261c6311d11\", \"vr_common_unittests\": \"d440e1fa1c3bfc8fbd4ddad5dba9629724b8f4a5\", \"vr_pixeltests\": \"03234d83efdaf00bf6d8549b295958e85f4c786c\", \"webdriver_wpt_tests\": \"62724561c4d78d50ebcf11ca09dba54a632a035b\", \"weblayer_browsertests\": \"36cd175f37812eea2625248e7bfd0cf9d1b13308\", \"weblayer_unittests\": \"f19671de3f1481e28d777700b8258a0fd6c110c3\", \"wm_unittests\": \"2835a93c29e4b846f1b3e56accb2aa3bccb4e729\", \"wtf_unittests\": \"094dc87d4a8717e036c268565a018d24fa87df00\", \"x11_unittests\": \"8f0bc5d21c57b7d2dbc6878efc920358825c3d32\", \"xr_browser_tests\": \"36ef1819ff21e211ffc08dd21d0affa59665f9e3\", \"zlib_unittests\": \"8e93d5677a8372d13c072743a648006412f87444\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0111b226b6a2e1a66cbbf5d93fde4367495bc99d98428795ba3e931083c57f27_v2\", \"builder_093d924ecb526dae9a1dcf9db4725f8944eec2b4c0f2ddc6c2ac4a04802f7f15_v2\", \"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_609b54f795c46f6da98bce3e3c3edeb2c2e2d72c7759cc5040a86edccd734c7c_v2\", \"builder_c5a4a77f7d90ed750e2e3c196231723a8f9435afca7311d8fa2536a9dada12e3_v2\", \"builder_d99b56d6fc6fd15316497c0509dbc8d437110174a09b554c19aeca35e1687cdb_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_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-58-w6bq\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610914175241623",
"status": "COMPLETED",
"status_changed_ts": "1610919382463862",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179716",
"builder:Linux Builder (dbg)",
"buildset:commit/git/66b48e783de0b7944bd9f36bdae1bf60c7b51e0d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/66b48e783de0b7944bd9f36bdae1bf60c7b51e0d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023259194758342208",
"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/8857829132570248672/+/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:512ab55e9e615c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610919382476368",
"url": "https://ci.chromium.org/b/8857829132570248672",
"utcnow_ts": "1610919382918118"
}
}
[21:36:22.926] Invocation finished in 1h48m25.036321069s with status SUCCEEDED