[23:11:02.152] New invocation is queued and will start shortly
[23:11:03.227] Starting the invocation (attempt 1)
[23:11:03.265] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:11:03.265] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:11:03.265] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025873730676606640",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"bfab7262cd6e600b78d0c0f2754cfe41fcb274bd\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9025873730676606640",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/bfab7262cd6e600b78d0c0f2754cfe41fcb274bd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bfab7262cd6e600b78d0c0f2754cfe41fcb274bd",
"gitiles_ref:refs/heads/master"
]
}
[23:11:03.918] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608419463338809",
"id": "8860443668769656272",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bfab7262cd6e600b78d0c0f2754cfe41fcb274bd\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608419463709955",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178832",
"builder:Linux Builder (dbg)",
"buildset:commit/git/bfab7262cd6e600b78d0c0f2754cfe41fcb274bd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bfab7262cd6e600b78d0c0f2754cfe41fcb274bd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025873730676606640",
"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/8860443668769656272/+/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": "1608419463710059",
"url": "https://ci.chromium.org/b/8860443668769656272",
"utcnow_ts": "1608419463903161"
}
}
[23:11:03.918] Task URL: https://ci.chromium.org/b/8860443668769656272
[23:11:03.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:2:0) after 1m0s
[23:12:03.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:2:0)
[23:12:03.954] Timer tick, asking Buildbucket for the build status
[23:12:04.086] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:04.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:3:0) after 1m0s
[23:13:04.119] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:3:0)
[23:13:04.119] Timer tick, asking Buildbucket for the build status
[23:13:04.543] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:04.543] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:4:0) after 1m0s
[23:14:04.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:4:0)
[23:14:04.560] Timer tick, asking Buildbucket for the build status
[23:14:04.644] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:04.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:5:0) after 1m0s
[23:15:04.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:5:0)
[23:15:04.716] Timer tick, asking Buildbucket for the build status
[23:15:05.193] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:05.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:6:0) after 1m0s
[23:16:05.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:6:0)
[23:16:05.333] Timer tick, asking Buildbucket for the build status
[23:16:05.422] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:05.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:7:0) after 1m0s
[23:17:05.443] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:7:0)
[23:17:05.443] Timer tick, asking Buildbucket for the build status
[23:17:05.509] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:05.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:8:0) after 1m0s
[23:18:05.610] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:8:0)
[23:18:05.610] Timer tick, asking Buildbucket for the build status
[23:18:05.674] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:05.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:9:0) after 1m0s
[23:19:05.734] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:9:0)
[23:19:05.734] Timer tick, asking Buildbucket for the build status
[23:19:05.828] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:05.828] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:10:0) after 1m0s
[23:20:05.899] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:10:0)
[23:20:05.899] Timer tick, asking Buildbucket for the build status
[23:20:05.976] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:05.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:11:0) after 1m0s
[23:21:06.005] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:11:0)
[23:21:06.005] Timer tick, asking Buildbucket for the build status
[23:21:06.107] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:06.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:12:0) after 1m0s
[23:22:06.123] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:12:0)
[23:22:06.123] Timer tick, asking Buildbucket for the build status
[23:22:06.181] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:06.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:13:0) after 1m0s
[23:23:06.203] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:13:0)
[23:23:06.203] Timer tick, asking Buildbucket for the build status
[23:23:06.435] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:06.435] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:14:0) after 1m0s
[23:24:06.540] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:14:0)
[23:24:06.540] Timer tick, asking Buildbucket for the build status
[23:24:06.671] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:06.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:15:0) after 1m0s
[23:25:06.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:15:0)
[23:25:06.730] Timer tick, asking Buildbucket for the build status
[23:25:06.807] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:06.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:16:0) after 1m0s
[23:26:06.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:16:0)
[23:26:06.807] Timer tick, asking Buildbucket for the build status
[23:26:07.208] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:07.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:17:0) after 1m0s
[23:27:07.217] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:17:0)
[23:27:07.217] Timer tick, asking Buildbucket for the build status
[23:27:07.297] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:07.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:18:0) after 1m0s
[23:28:07.313] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:18:0)
[23:28:07.313] Timer tick, asking Buildbucket for the build status
[23:28:07.379] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:07.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:19:0) after 1m0s
[23:29:07.452] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:19:0)
[23:29:07.452] Timer tick, asking Buildbucket for the build status
[23:29:07.547] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:07.547] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:20:0) after 1m0s
[23:30:07.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:20:0)
[23:30:07.568] Timer tick, asking Buildbucket for the build status
[23:30:07.710] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:07.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:21:0) after 1m0s
[23:31:07.735] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:21:0)
[23:31:07.735] Timer tick, asking Buildbucket for the build status
[23:31:07.826] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:07.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:22:0) after 1m0s
[23:32:07.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:22:0)
[23:32:07.846] Timer tick, asking Buildbucket for the build status
[23:32:08.176] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:08.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:23:0) after 1m0s
[23:33:08.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:23:0)
[23:33:08.204] Timer tick, asking Buildbucket for the build status
[23:33:08.434] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:08.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:24:0) after 1m0s
[23:34:08.566] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:24:0)
[23:34:08.566] Timer tick, asking Buildbucket for the build status
[23:34:08.632] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:08.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:25:0) after 1m0s
[23:35:08.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:25:0)
[23:35:08.675] Timer tick, asking Buildbucket for the build status
[23:35:08.890] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:08.890] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:26:0) after 1m0s
[23:36:08.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:26:0)
[23:36:08.909] Timer tick, asking Buildbucket for the build status
[23:36:08.987] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:08.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:27:0) after 1m0s
[23:37:09.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:27:0)
[23:37:09.064] Timer tick, asking Buildbucket for the build status
[23:37:09.169] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:09.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:28:0) after 1m0s
[23:38:09.301] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:28:0)
[23:38:09.301] Timer tick, asking Buildbucket for the build status
[23:38:09.411] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:09.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:29:0) after 1m0s
[23:39:09.485] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:29:0)
[23:39:09.485] Timer tick, asking Buildbucket for the build status
[23:39:09.544] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:09.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:30:0) after 1m0s
[23:40:09.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:30:0)
[23:40:09.621] Timer tick, asking Buildbucket for the build status
[23:40:09.826] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:09.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:31:0) after 1m0s
[23:41:09.816] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:31:0)
[23:41:09.816] Timer tick, asking Buildbucket for the build status
[23:41:09.937] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:09.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:32:0) after 1m0s
[23:42:10.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:32:0)
[23:42:10.014] Timer tick, asking Buildbucket for the build status
[23:42:10.346] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:10.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:33:0) after 1m0s
[23:43:10.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:33:0)
[23:43:10.368] Timer tick, asking Buildbucket for the build status
[23:43:10.672] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:10.672] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:34:0) after 1m0s
[23:44:10.751] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:34:0)
[23:44:10.751] Timer tick, asking Buildbucket for the build status
[23:44:11.166] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:11.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:35:0) after 1m0s
[23:45:11.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:35:0)
[23:45:11.185] Timer tick, asking Buildbucket for the build status
[23:45:11.459] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:11.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:36:0) after 1m0s
[23:46:11.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:36:0)
[23:46:11.480] Timer tick, asking Buildbucket for the build status
[23:46:11.553] Build 8860443668769656272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:11.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:37:0) after 1m0s
[23:46:47.849] Received PubSub notification, asking Buildbucket for the build status
[23:46:48.015] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:11.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:37:0)
[23:47:11.573] Timer tick, asking Buildbucket for the build status
[23:47:11.630] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:11.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:39:0) after 1m0s
[23:48:11.665] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:39:0)
[23:48:11.665] Timer tick, asking Buildbucket for the build status
[23:48:11.904] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:11.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:40:0) after 1m0s
[23:49:11.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:40:0)
[23:49:11.923] Timer tick, asking Buildbucket for the build status
[23:49:12.538] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:12.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:41:0) after 1m0s
[23:50:12.562] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:41:0)
[23:50:12.562] Timer tick, asking Buildbucket for the build status
[23:50:12.633] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:12.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:42:0) after 1m0s
[23:51:12.654] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:42:0)
[23:51:12.654] Timer tick, asking Buildbucket for the build status
[23:51:12.748] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:12.748] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:43:0) after 1m0s
[23:52:12.811] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:43:0)
[23:52:12.811] Timer tick, asking Buildbucket for the build status
[23:52:12.877] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:12.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:44:0) after 1m0s
[23:53:13.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:44:0)
[23:53:13.002] Timer tick, asking Buildbucket for the build status
[23:53:13.108] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:13.108] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:45:0) after 1m0s
[23:54:13.222] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:45:0)
[23:54:13.222] Timer tick, asking Buildbucket for the build status
[23:54:13.313] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:13.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:46:0) after 1m0s
[23:55:13.319] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:46:0)
[23:55:13.319] Timer tick, asking Buildbucket for the build status
[23:55:13.415] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:13.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:47:0) after 1m0s
[23:56:13.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:47:0)
[23:56:13.434] Timer tick, asking Buildbucket for the build status
[23:56:13.922] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:13.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:48:0) after 1m0s
[23:57:14.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:48:0)
[23:57:14.032] Timer tick, asking Buildbucket for the build status
[23:57:14.720] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:14.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:49:0) after 1m0s
[23:58:14.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:49:0)
[23:58:14.792] Timer tick, asking Buildbucket for the build status
[23:58:14.871] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:14.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:50:0) after 1m0s
[23:59:14.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:50:0)
[23:59:14.994] Timer tick, asking Buildbucket for the build status
[23:59:15.292] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:15.292] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:51:0) after 1m0s
[00:00:15.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:51:0)
[00:00:15.461] Timer tick, asking Buildbucket for the build status
[00:00:15.662] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:15.662] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:52:0) after 1m0s
[00:01:15.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:52:0)
[00:01:15.721] Timer tick, asking Buildbucket for the build status
[00:01:15.838] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:15.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:53:0) after 1m0s
[00:02:15.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:53:0)
[00:02:15.848] Timer tick, asking Buildbucket for the build status
[00:02:15.901] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:15.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:54:0) after 1m0s
[00:03:17.530] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:54:0)
[00:03:17.530] Timer tick, asking Buildbucket for the build status
[00:03:17.576] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:17.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:55:0) after 1m0s
[00:04:19.957] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:55:0)
[00:04:19.957] Timer tick, asking Buildbucket for the build status
[00:04:20.036] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:20.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:56:0) after 1m0s
[00:05:20.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:56:0)
[00:05:20.073] Timer tick, asking Buildbucket for the build status
[00:05:20.205] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:20.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:57:0) after 1m0s
[00:06:20.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:57:0)
[00:06:20.316] Timer tick, asking Buildbucket for the build status
[00:06:20.412] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:20.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:58:0) after 1m0s
[00:07:20.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:58:0)
[00:07:20.419] Timer tick, asking Buildbucket for the build status
[00:07:20.474] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:20.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:59:0) after 1m0s
[00:08:20.499] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:59:0)
[00:08:20.499] Timer tick, asking Buildbucket for the build status
[00:08:20.574] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:20.574] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:60:0) after 1m0s
[00:09:20.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:60:0)
[00:09:20.596] Timer tick, asking Buildbucket for the build status
[00:09:20.859] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:20.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:61:0) after 1m0s
[00:10:20.883] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:61:0)
[00:10:20.883] Timer tick, asking Buildbucket for the build status
[00:10:21.369] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:21.369] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:62:0) after 1m0s
[00:11:21.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:62:0)
[00:11:21.395] Timer tick, asking Buildbucket for the build status
[00:11:21.567] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:21.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:63:0) after 1m0s
[00:12:21.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:63:0)
[00:12:21.609] Timer tick, asking Buildbucket for the build status
[00:12:21.692] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:21.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:64:0) after 1m0s
[00:13:21.668] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:64:0)
[00:13:21.668] Timer tick, asking Buildbucket for the build status
[00:13:21.738] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:21.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:65:0) after 1m0s
[00:14:21.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:65:0)
[00:14:21.753] Timer tick, asking Buildbucket for the build status
[00:14:21.804] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:21.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:66:0) after 1m0s
[00:15:21.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:66:0)
[00:15:21.825] Timer tick, asking Buildbucket for the build status
[00:15:21.877] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:21.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:67:0) after 1m0s
[00:16:21.899] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:67:0)
[00:16:21.899] Timer tick, asking Buildbucket for the build status
[00:16:22.023] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:22.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:68:0) after 1m0s
[00:17:22.131] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:68:0)
[00:17:22.131] Timer tick, asking Buildbucket for the build status
[00:17:22.186] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:22.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:69:0) after 1m0s
[00:18:22.198] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:69:0)
[00:18:22.198] Timer tick, asking Buildbucket for the build status
[00:18:22.267] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:22.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:70:0) after 1m0s
[00:19:22.356] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:70:0)
[00:19:22.356] Timer tick, asking Buildbucket for the build status
[00:19:22.430] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:22.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:71:0) after 1m0s
[00:20:22.452] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:71:0)
[00:20:22.452] Timer tick, asking Buildbucket for the build status
[00:20:22.611] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:22.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:72:0) after 1m0s
[00:21:22.637] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:72:0)
[00:21:22.637] Timer tick, asking Buildbucket for the build status
[00:21:22.960] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:22.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:73:0) after 1m0s
[00:22:23.020] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:73:0)
[00:22:23.020] Timer tick, asking Buildbucket for the build status
[00:22:23.109] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:23.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:74:0) after 1m0s
[00:23:23.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:74:0)
[00:23:23.116] Timer tick, asking Buildbucket for the build status
[00:23:23.302] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:23.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:75:0) after 1m0s
[00:24:23.336] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:75:0)
[00:24:23.336] Timer tick, asking Buildbucket for the build status
[00:24:23.389] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:23.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:76:0) after 1m0s
[00:25:23.413] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:76:0)
[00:25:23.413] Timer tick, asking Buildbucket for the build status
[00:25:23.602] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:23.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:77:0) after 1m0s
[00:26:23.623] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:77:0)
[00:26:23.623] Timer tick, asking Buildbucket for the build status
[00:26:23.976] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:23.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:78:0) after 1m0s
[00:27:24.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:78:0)
[00:27:24.039] Timer tick, asking Buildbucket for the build status
[00:27:24.144] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:24.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:79:0) after 1m0s
[00:28:24.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:79:0)
[00:28:24.199] Timer tick, asking Buildbucket for the build status
[00:28:24.249] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:24.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:80:0) after 1m0s
[00:29:24.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:80:0)
[00:29:24.371] Timer tick, asking Buildbucket for the build status
[00:29:24.423] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:24.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:81:0) after 1m0s
[00:30:24.458] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:81:0)
[00:30:24.458] Timer tick, asking Buildbucket for the build status
[00:30:24.523] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:24.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:82:0) after 1m0s
[00:31:24.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:82:0)
[00:31:24.503] Timer tick, asking Buildbucket for the build status
[00:31:24.590] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:24.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:83:0) after 1m0s
[00:32:24.648] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:83:0)
[00:32:24.648] Timer tick, asking Buildbucket for the build status
[00:32:24.999] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:24.999] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:84:0) after 1m0s
[00:33:24.995] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:84:0)
[00:33:24.996] Timer tick, asking Buildbucket for the build status
[00:33:25.254] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:25.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:85:0) after 1m0s
[00:34:25.298] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:85:0)
[00:34:25.298] Timer tick, asking Buildbucket for the build status
[00:34:25.366] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:25.366] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:86:0) after 1m0s
[00:35:25.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:86:0)
[00:35:25.372] Timer tick, asking Buildbucket for the build status
[00:35:25.430] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:25.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:87:0) after 1m0s
[00:36:25.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:87:0)
[00:36:25.455] Timer tick, asking Buildbucket for the build status
[00:36:25.696] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:25.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:88:0) after 1m0s
[00:37:25.718] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:88:0)
[00:37:25.718] Timer tick, asking Buildbucket for the build status
[00:37:25.797] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:25.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:89:0) after 1m0s
[00:38:25.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:89:0)
[00:38:25.830] Timer tick, asking Buildbucket for the build status
[00:38:25.975] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:25.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:90:0) after 1m0s
[00:39:26.009] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:90:0)
[00:39:26.009] Timer tick, asking Buildbucket for the build status
[00:39:26.250] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:26.250] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:91:0) after 1m0s
[00:40:26.335] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:91:0)
[00:40:26.335] Timer tick, asking Buildbucket for the build status
[00:40:26.386] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:26.386] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:92:0) after 1m0s
[00:41:26.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:92:0)
[00:41:26.422] Timer tick, asking Buildbucket for the build status
[00:41:26.525] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:26.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:93:0) after 1m0s
[00:42:26.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:93:0)
[00:42:26.546] Timer tick, asking Buildbucket for the build status
[00:42:26.917] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:26.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:94:0) after 1m0s
[00:43:26.961] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:94:0)
[00:43:26.961] Timer tick, asking Buildbucket for the build status
[00:43:27.114] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:27.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:95:0) after 1m0s
[00:44:27.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:95:0)
[00:44:27.136] Timer tick, asking Buildbucket for the build status
[00:44:27.187] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:27.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:96:0) after 1m0s
[00:45:27.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:96:0)
[00:45:27.207] Timer tick, asking Buildbucket for the build status
[00:45:27.322] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:27.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:97:0) after 1m0s
[00:46:27.410] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:97:0)
[00:46:27.410] Timer tick, asking Buildbucket for the build status
[00:46:27.871] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:27.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:98:0) after 1m0s
[00:47:27.943] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:98:0)
[00:47:27.943] Timer tick, asking Buildbucket for the build status
[00:47:27.999] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:27.999] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:99:0) after 1m0s
[00:48:28.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:99:0)
[00:48:28.038] Timer tick, asking Buildbucket for the build status
[00:48:28.102] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:28.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:100:0) after 1m0s
[00:49:28.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:100:0)
[00:49:28.124] Timer tick, asking Buildbucket for the build status
[00:49:28.177] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:28.177] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:101:0) after 1m0s
[00:50:28.198] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:101:0)
[00:50:28.198] Timer tick, asking Buildbucket for the build status
[00:50:28.302] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:28.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:102:0) after 1m0s
[00:51:28.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:102:0)
[00:51:28.341] Timer tick, asking Buildbucket for the build status
[00:51:28.499] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:28.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:103:0) after 1m0s
[00:52:28.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:103:0)
[00:52:28.520] Timer tick, asking Buildbucket for the build status
[00:52:28.693] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:28.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:104:0) after 1m0s
[00:53:28.712] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:104:0)
[00:53:28.712] Timer tick, asking Buildbucket for the build status
[00:53:28.796] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:28.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:105:0) after 1m0s
[00:54:28.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:105:0)
[00:54:28.888] Timer tick, asking Buildbucket for the build status
[00:54:29.147] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:29.147] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:106:0) after 1m0s
[00:55:29.175] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:106:0)
[00:55:29.175] Timer tick, asking Buildbucket for the build status
[00:55:29.481] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:29.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:107:0) after 1m0s
[00:56:29.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:107:0)
[00:56:29.551] Timer tick, asking Buildbucket for the build status
[00:56:29.779] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:29.779] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:108:0) after 1m0s
[00:57:29.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:108:0)
[00:57:29.851] Timer tick, asking Buildbucket for the build status
[00:57:30.213] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:30.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:109:0) after 1m0s
[00:58:30.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:109:0)
[00:58:30.281] Timer tick, asking Buildbucket for the build status
[00:58:30.337] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:30.337] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:110:0) after 1m0s
[00:59:30.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:110:0)
[00:59:30.402] Timer tick, asking Buildbucket for the build status
[00:59:30.455] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:30.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:111:0) after 1m0s
[01:00:31.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:111:0)
[01:00:31.748] Timer tick, asking Buildbucket for the build status
[01:00:31.880] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:31.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:112:0) after 1m0s
[01:01:31.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:112:0)
[01:01:31.992] Timer tick, asking Buildbucket for the build status
[01:01:32.101] Build 8860443668769656272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:32.101] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025873730676606640:113:0) after 1m0s
[01:02:17.580] Received PubSub notification, asking Buildbucket for the build status
[01:02:17.678] Build 8860443668769656272: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:02:17.678] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608426136599415",
"created_by": "project:chromium",
"created_ts": "1608419463338809",
"id": "8860443668769656272",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bfab7262cd6e600b78d0c0f2754cfe41fcb274bd\"}}",
"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\": \"bfab7262cd6e600b78d0c0f2754cfe41fcb274bd\", \"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-6-d4z4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178832, \"got_angle_revision\": \"ed9213bca0643edb65b7d39a938210419398a1b3\", \"got_dawn_revision\": \"5d4fd88a7403aa255d49919d011af54c691b344a\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"bfab7262cd6e600b78d0c0f2754cfe41fcb274bd\", \"got_revision_cp\": \"refs/heads/master@{#838535}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"c4b600873d9668aeeb4f28e20f86d82b5c75379c\", \"got_v8_revision_cp\": \"refs/heads/8.9.177@{#1}\", \"got_webrtc_revision\": \"d7f750f7be4b2f61018d3cb55a995d09daa226e6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32862}\", \"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\": \"bfab7262cd6e600b78d0c0f2754cfe41fcb274bd\", \"swarm_hashes_refs/heads/master(at){#838535}_without_patch\": {\"absl_hardening_tests\": \"8f375d384e5b8a2ebdecc24bca0624147a11a2f1\", \"accessibility_unittests\": \"36a3c864e08615de3d88baaebf735d1eef6badff\", \"angle_unittests\": \"6291cbe995b57c402b427dcd62f8f6abc7b60ab2\", \"app_shell_unittests\": \"4af6f15bc877ad850b37ed3828157563b569f941\", \"aura_unittests\": \"ffa97cdd976071b6b33f65fef15c297d74d653b5\", \"base_unittests\": \"d707ed28b15b976451dca9fc89e14bff4ab070bc\", \"base_util_unittests\": \"84b03bad7f08af7e4c9c18e185422390f121e9d4\", \"blink_common_unittests\": \"3fd37ecdf6dc47e32c6d129064ce504c92c9a90a\", \"blink_fuzzer_unittests\": \"cdff362b13b8f5ec8bcaceac7b0b12631ba64884\", \"blink_heap_unittests\": \"ff27128c66751bbf860d837af32496a7cad09427\", \"blink_platform_unittests\": \"8675b785d48806d5b664282011f98d6ff0af4ad2\", \"blink_python_tests\": \"a850068bffdc4a670df6ad15aeda052beec9a023\", \"blink_unittests\": \"e3c4a05db9a95a0dcfd48f5d0ba90cfcc4f6a573\", \"blink_web_tests\": \"dbb959ca6eddf8119d7a2177290527c7b91723ea\", \"boringssl_crypto_tests\": \"339c2652771d7b3e164a30240cc807aad06fc5f2\", \"boringssl_ssl_tests\": \"4125b55d8cb2aefef23667153037cfe9fe874c0e\", \"browser_tests\": \"0dbf35a7f844da2aa35b6be3ac8074a453d3cd2d\", \"capture_unittests\": \"23b4aa60d41525be6632e8accc633611c6a1b467\", \"cast_unittests\": \"401fc1e8214ac0c5c7a4cee69c5e8e7c6fa3f597\", \"cc_unittests\": \"644fe35a7b0c44d103169e57e1ffe4fc385718c0\", \"chrome_app_unittests\": \"cf3327a3fb320759baed6be5e377e41451d063d2\", \"chromedriver_unittests\": \"40929ddf84fc38c3bc98fe8a70294928ac24baa9\", \"components_browsertests\": \"1b8658ca46e9d936f975dd13097ea8471fecc7d9\", \"components_unittests\": \"0c5e94792f7063291be43330c528e1d1933a5a7f\", \"compositor_unittests\": \"9ef2a564cf4f9905bf9c3ff02801d73e8d1c50e0\", \"content_browsertests\": \"d40297677db99803bc22b2345f840cc357d3ea2d\", \"content_shell_crash_test\": \"137edec7fbcf42b81427c9736fa6a28b0b7f5c16\", \"content_unittests\": \"1ec931c8d3151f3c5cbeabc1ce38da08244c2b92\", \"crashpad_tests\": \"49f3237b435657bd0a41708c953bbb6e2282e049\", \"cronet_tests\": \"b3083194d91cd5974dbe4e5a061d21a307589f97\", \"cronet_unittests\": \"4a06513acb5948251e6c6389f9c8475572522816\", \"crypto_unittests\": \"b4ea65d67dbc4046191211f280ea3161f64e3024\", \"dbus_unittests\": \"97b1705f3871e03b4dd6c1be2b4fd003b75ee19e\", \"device_unittests\": \"e9e64292220422e55ba575de9f53cd46ea3cc74f\", \"display_unittests\": \"1c1488fcfa9585b82ac28da69227dda2355b6d2e\", \"events_unittests\": \"e812e1d4131faf79bb7eccfe3f628c3e60697bf8\", \"extension_docserver_python_unittests\": \"71bcd6b7573d94ae1247016c00563f0ec7b193dc\", \"extensions_browsertests\": \"601b85256309b5b8f511c8fa8b96fc96061acc79\", \"extensions_unittests\": \"27a29b19bb421aa8fc3c113a70f776354b369e89\", \"filesystem_service_unittests\": \"0b40852fd3775977720bbc5f6e20cd46754b1bb3\", \"flatbuffers_unittests\": \"d051d66da1ab229778a7e9a8f6ace686eaf5e782\", \"gcm_unit_tests\": \"e90fe9b5a95b5ec75bcdab60d4bb303893dc8073\", \"gfx_unittests\": \"d80a33fcc75e2896c72da7413bc49df4d33995b3\", \"gin_unittests\": \"46168b48775b31b3cc81000691150e3347ef3b55\", \"google_apis_unittests\": \"c6122452f4019d56071922195c064c39bde6e8af\", \"gpu_unittests\": \"dba44cd938b126a9050d94a737f9a3ba870f7c43\", \"grit_python_unittests\": \"275c161e38b800af0a18bf8ee2ae20e83dfa4ea2\", \"gwp_asan_unittests\": \"85a4409656e25530c6e025787387b24b69465007\", \"headless_browsertests\": \"9db7e299e53266eec0a41367ece449dce817fb0d\", \"headless_unittests\": \"0e5ad58ccc193540045599067feab45322c5aa80\", \"interactive_ui_tests\": \"f1295cc7700fa5f114fcf5618680ab4dcd09e591\", \"ipc_tests\": \"2b1624151520172c529bfbe9fb113c1d5013ff29\", \"jingle_unittests\": \"452872d6f92a9bdba5c40f6fcd6300f60982daca\", \"latency_unittests\": \"1f6b809923b319be1fb8e042ad9330f1ee73733b\", \"libjingle_xmpp_unittests\": \"892a002b30cf1f12b3008fdc93270d3bedfc9e06\", \"liburlpattern_unittests\": \"2474b765488b21a51c6bda6602ca1fc506c1de64\", \"media_blink_unittests\": \"90d252dfa1977479083d6dcbbea5005f3fabd654\", \"media_unittests\": \"56d750464c9a28760c02d2cdb19a628c1d0bf301\", \"message_center_unittests\": \"d36644a2034e67860103e377241f1758c9b3e71f\", \"metrics_python_tests\": \"9a057f240d8e448aea1f99ca8cd2be4817085334\", \"midi_unittests\": \"57a890852d18c64577e69240879eddae32ad007f\", \"mojo_core_unittests\": \"abb7d61cbf24e8c91d09191c5de588526a852443\", \"mojo_unittests\": \"b94a9515601f87d291537e9d61690e18d334b4fa\", \"nacl_helper_nonsfi_unittests\": \"504b27c5496dae8f718aa86efc3942da9cd9266e\", \"nacl_loader_unittests\": \"ab64b9733f0ba3893a4b8a664b3be7781b00994c\", \"native_theme_unittests\": \"095c58f890dd164668aec7880c983a4f0a310d28\", \"net_unittests\": \"ed63b978e2b48113613bbefe2bcd473d2b071a8e\", \"openscreen_unittests\": \"55d9b91739be4d3d661d9671a7aa8ef9a28c06d4\", \"pdf_unittests\": \"9c1d8937ad83bfb71be75a0b34c97ac15afd9b92\", \"perfetto_unittests\": \"2b4794f2711a3c606bb1b5db4b17b4c5bc51e90d\", \"ppapi_unittests\": \"1cc897984e64fc87d976f0678bd1bcfa7fe2bd1d\", \"printing_unittests\": \"32c3ec7dadf5943c19bda8b982595d2bd9f39117\", \"remoting_unittests\": \"804d5d7e086e4a5a5d7977613e12cd23f976a80c\", \"sandbox_linux_unittests\": \"7b6c06a037257977d5ce0d7d5edadaef9eb97a47\", \"service_manager_unittests\": \"bf338b4006bffdca8e3ed213a48673ffaa0bc226\", \"services_unittests\": \"5d869c305da1b205627e05c0fa045291b18b57a8\", \"shell_dialogs_unittests\": \"31d2edbbd8ffb099ddfa8ffe204c32b1f403467a\", \"skia_unittests\": \"8a160b4b94a76a09827149d11673f1ee5bf9e7a1\", \"snapshot_unittests\": \"5312d10abe01b33669cdd589fa3eca8cf33a6281\", \"sql_unittests\": \"29d5e2732b97881338fedde8246ed0f24f84b4b7\", \"storage_unittests\": \"c9e994b5fb0cc2e7921272d1bf17cbfc76ea69e1\", \"sync_integration_tests\": \"6e5d2a28aafd739712a0d6b73e0420878f8045fb\", \"telemetry_gpu_unittests\": \"72e49f1d6f8f2162e1e79a624e9ce46fee20ad43\", \"telemetry_perf_unittests\": \"8779a0f2c5ecb8e768ff6b1b2def36095943760e\", \"telemetry_unittests\": \"9a024a3bfca848c0dcec1b5d5cbc1ccd168c6b36\", \"traffic_annotation_auditor_unittests\": \"5fc96914b84f2ff7bb978b419faf57a1a1405c1b\", \"ui_base_unittests\": \"c5e92b53902da42777b5f12718f29dc3c831a433\", \"ui_touch_selection_unittests\": \"a688cc0e25664543eaa99c1b68a9bbe31eef3ae0\", \"unit_tests\": \"ecaed5f91788d02f09e3055ea3bf6effedf4aed8\", \"url_unittests\": \"5b822a9d7fbf590f3099afe3a26445eb7a924efb\", \"views_perftests\": \"4e271ef72b33ad614d04f852ba7ea24cfd8594c0\", \"views_unittests\": \"913d23a43b33a78711d92bccd6923da8d6ca325e\", \"viz_unittests\": \"fc2316f07fbb3332b05e0e5b689c1b1091078b96\", \"vr_common_unittests\": \"87fe23ed02f667387ccd8f28a03f4ed5b3080f4e\", \"vr_pixeltests\": \"802ea3ce6b233b068ab5a4076ace29ba665f18fb\", \"webdriver_wpt_tests\": \"442cbf26059d391f76e94a22676cbede973088e6\", \"weblayer_browsertests\": \"456fee020ccfb22015dce2e0add531da0eb2a24a\", \"weblayer_unittests\": \"0114ec73c338ae94a0be557f619ce81167fdef3d\", \"wm_unittests\": \"2113f25a90408323819c5d0adc85a60ca0e84d20\", \"wtf_unittests\": \"55531b456c95a8aa2f065d15f627fd8caa344c84\", \"x11_unittests\": \"66680cbb5846464724070a4fc78f702eb7f9e0bf\", \"xr_browser_tests\": \"ccd7bafe0c1177cdc4724668b3a99f1b0953944f\", \"zlib_unittests\": \"d7b4949fd0c0340e972b0ab41b48f91449fbaa72\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_151f80801b9f29276c11c5f05dab27ce5673f9c9ba442aaf2cf20aab9215f522_v2\", \"builder_2295bac873f7edd8c9763e89419d85b38a875955550d968c436d775d3f06377b_v2\", \"builder_2b25d58305a6755482534765a65f2521477c19af0731994631a8cf25b9f3b571_v2\", \"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_5f931a5519f78feef046af549827aa56dc2e9b17853b60b3d0ae8ebd533780ee_v2\", \"builder_ded6992437bb43fbf38c4db56f613c83c13b8efc5129044b4fc05fb02888bbc4_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-6-d4z4\"], \"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": "1608421607300917",
"status": "COMPLETED",
"status_changed_ts": "1608426137289937",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178832",
"builder:Linux Builder (dbg)",
"buildset:commit/git/bfab7262cd6e600b78d0c0f2754cfe41fcb274bd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bfab7262cd6e600b78d0c0f2754cfe41fcb274bd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025873730676606640",
"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/8860443668769656272/+/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:509616dc70d0ea10",
"user_agent:luci-scheduler"
],
"updated_ts": "1608426137297386",
"url": "https://ci.chromium.org/b/8860443668769656272",
"utcnow_ts": "1608426137669895"
}
}
[01:02:17.678] Invocation finished in 1h51m15.542931335s with status SUCCEEDED