[13:51:48.987] New invocation is queued and will start shortly
[13:51:50.045] Starting the invocation (attempt 1)
[13:51:50.082] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:51:50.082] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:51:50.082] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021469662363730720",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"20f315408a4f49da7896b69c4be90dbc5d984eea\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021469662363730720",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/20f315408a4f49da7896b69c4be90dbc5d984eea",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/20f315408a4f49da7896b69c4be90dbc5d984eea",
"gitiles_ref:refs/heads/master"
]
}
[13:51:50.942] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612619510180738",
"id": "8856039600451994032",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"20f315408a4f49da7896b69c4be90dbc5d984eea\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612619510627809",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180336",
"builder:Linux Builder (dbg)",
"buildset:commit/git/20f315408a4f49da7896b69c4be90dbc5d984eea",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/20f315408a4f49da7896b69c4be90dbc5d984eea",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021469662363730720",
"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/8856039600451994032/+/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": "1612619510627926",
"url": "https://ci.chromium.org/b/8856039600451994032",
"utcnow_ts": "1612619510932801"
}
}
[13:51:50.942] Task URL: https://ci.chromium.org/b/8856039600451994032
[13:51:50.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:2:0) after 1m0s
[13:52:51.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:2:0)
[13:52:51.012] Timer tick, asking Buildbucket for the build status
[13:52:51.792] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:52:51.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:3:0) after 1m0s
[13:53:51.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:3:0)
[13:53:51.848] Timer tick, asking Buildbucket for the build status
[13:53:52.024] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:53:52.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:4:0) after 1m0s
[13:54:52.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:4:0)
[13:54:52.023] Timer tick, asking Buildbucket for the build status
[13:54:52.272] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:54:52.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:5:0) after 1m0s
[13:55:52.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:5:0)
[13:55:52.329] Timer tick, asking Buildbucket for the build status
[13:55:52.443] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:55:52.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:6:0) after 1m0s
[13:56:52.490] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:6:0)
[13:56:52.490] Timer tick, asking Buildbucket for the build status
[13:56:52.997] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:56:52.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:7:0) after 1m0s
[13:57:53.005] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:7:0)
[13:57:53.005] Timer tick, asking Buildbucket for the build status
[13:57:53.473] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:57:53.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:8:0) after 1m0s
[13:58:53.588] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:8:0)
[13:58:53.588] Timer tick, asking Buildbucket for the build status
[13:58:53.955] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:58:53.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:9:0) after 1m0s
[13:59:54.033] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:9:0)
[13:59:54.033] Timer tick, asking Buildbucket for the build status
[13:59:54.105] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:59:54.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:10:0) after 1m0s
[14:00:54.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:10:0)
[14:00:54.154] Timer tick, asking Buildbucket for the build status
[14:00:54.413] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:00:54.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:11:0) after 1m0s
[14:01:54.509] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:11:0)
[14:01:54.509] Timer tick, asking Buildbucket for the build status
[14:01:54.611] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:01:54.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:12:0) after 1m0s
[14:02:54.697] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:12:0)
[14:02:54.697] Timer tick, asking Buildbucket for the build status
[14:02:54.770] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:02:54.770] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:13:0) after 1m0s
[14:03:54.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:13:0)
[14:03:54.823] Timer tick, asking Buildbucket for the build status
[14:03:55.039] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:03:55.039] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:14:0) after 1m0s
[14:04:55.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:14:0)
[14:04:55.015] Timer tick, asking Buildbucket for the build status
[14:04:55.218] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:04:55.218] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:15:0) after 1m0s
[14:05:55.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:15:0)
[14:05:55.380] Timer tick, asking Buildbucket for the build status
[14:05:55.467] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:05:55.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:16:0) after 1m0s
[14:06:55.485] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:16:0)
[14:06:55.485] Timer tick, asking Buildbucket for the build status
[14:06:55.599] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:06:55.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:17:0) after 1m0s
[14:07:55.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:17:0)
[14:07:55.622] Timer tick, asking Buildbucket for the build status
[14:07:56.022] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:07:56.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:18:0) after 1m0s
[14:08:56.044] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:18:0)
[14:08:56.044] Timer tick, asking Buildbucket for the build status
[14:08:56.162] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:08:56.162] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:19:0) after 1m0s
[14:09:56.183] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:19:0)
[14:09:56.183] Timer tick, asking Buildbucket for the build status
[14:09:56.437] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:09:56.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:20:0) after 1m0s
[14:10:56.478] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:20:0)
[14:10:56.478] Timer tick, asking Buildbucket for the build status
[14:10:56.698] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:10:56.698] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:21:0) after 1m0s
[14:11:56.784] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:21:0)
[14:11:56.784] Timer tick, asking Buildbucket for the build status
[14:11:57.346] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:11:57.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:22:0) after 1m0s
[14:12:57.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:22:0)
[14:12:57.368] Timer tick, asking Buildbucket for the build status
[14:12:57.517] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:12:57.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:23:0) after 1m0s
[14:13:57.537] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:23:0)
[14:13:57.537] Timer tick, asking Buildbucket for the build status
[14:13:57.638] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:13:57.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:24:0) after 1m0s
[14:14:57.653] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:24:0)
[14:14:57.653] Timer tick, asking Buildbucket for the build status
[14:14:57.826] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:14:57.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:25:0) after 1m0s
[14:15:57.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:25:0)
[14:15:57.864] Timer tick, asking Buildbucket for the build status
[14:15:57.944] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:15:57.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:26:0) after 1m0s
[14:16:57.920] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:26:0)
[14:16:57.920] Timer tick, asking Buildbucket for the build status
[14:16:58.102] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:16:58.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:27:0) after 1m0s
[14:17:58.123] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:27:0)
[14:17:58.123] Timer tick, asking Buildbucket for the build status
[14:17:58.315] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:17:58.315] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:28:0) after 1m0s
[14:18:58.348] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:28:0)
[14:18:58.348] Timer tick, asking Buildbucket for the build status
[14:18:59.649] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:18:59.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:29:0) after 1m0s
[14:19:59.689] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:29:0)
[14:19:59.689] Timer tick, asking Buildbucket for the build status
[14:20:00.996] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:20:00.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:30:0) after 1m0s
[14:21:01.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:30:0)
[14:21:01.129] Timer tick, asking Buildbucket for the build status
[14:21:01.298] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:21:01.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:31:0) after 1m0s
[14:22:01.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:31:0)
[14:22:01.607] Timer tick, asking Buildbucket for the build status
[14:22:01.797] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:22:01.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:32:0) after 1m0s
[14:23:01.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:32:0)
[14:23:01.822] Timer tick, asking Buildbucket for the build status
[14:23:03.236] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:23:03.236] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:33:0) after 1m0s
[14:24:03.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:33:0)
[14:24:03.300] Timer tick, asking Buildbucket for the build status
[14:24:03.467] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:24:03.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:34:0) after 1m0s
[14:25:03.625] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:34:0)
[14:25:03.625] Timer tick, asking Buildbucket for the build status
[14:25:04.782] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:25:04.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:35:0) after 1m0s
[14:26:04.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:35:0)
[14:26:04.885] Timer tick, asking Buildbucket for the build status
[14:26:04.967] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:26:04.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:36:0) after 1m0s
[14:27:05.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:36:0)
[14:27:05.053] Timer tick, asking Buildbucket for the build status
[14:27:05.425] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:27:05.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:37:0) after 1m0s
[14:28:05.451] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:37:0)
[14:28:05.452] Timer tick, asking Buildbucket for the build status
[14:28:05.825] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:28:05.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:38:0) after 1m0s
[14:29:05.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:38:0)
[14:29:05.844] Timer tick, asking Buildbucket for the build status
[14:29:05.910] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:29:05.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:39:0) after 1m0s
[14:30:06.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:39:0)
[14:30:06.002] Timer tick, asking Buildbucket for the build status
[14:30:06.184] Build 8856039600451994032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:30:06.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:40:0) after 1m0s
[14:31:05.296] Received PubSub notification, asking Buildbucket for the build status
[14:31:05.639] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:06.840] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:40:0)
[14:31:06.840] Timer tick, asking Buildbucket for the build status
[14:31:06.990] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:06.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:42:0) after 1m0s
[14:32:07.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:42:0)
[14:32:07.077] Timer tick, asking Buildbucket for the build status
[14:32:07.302] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:07.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:43:0) after 1m0s
[14:33:07.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:43:0)
[14:33:07.339] Timer tick, asking Buildbucket for the build status
[14:33:07.522] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:07.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:44:0) after 1m0s
[14:34:07.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:44:0)
[14:34:07.756] Timer tick, asking Buildbucket for the build status
[14:34:08.523] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:08.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:45:0) after 1m0s
[14:35:08.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:45:0)
[14:35:08.664] Timer tick, asking Buildbucket for the build status
[14:35:08.775] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:08.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:46:0) after 1m0s
[14:36:08.798] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:46:0)
[14:36:08.798] Timer tick, asking Buildbucket for the build status
[14:36:08.901] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:08.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:47:0) after 1m0s
[14:37:08.966] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:47:0)
[14:37:08.966] Timer tick, asking Buildbucket for the build status
[14:37:09.556] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:09.556] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:48:0) after 1m0s
[14:38:09.554] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:48:0)
[14:38:09.554] Timer tick, asking Buildbucket for the build status
[14:38:09.733] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:09.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:49:0) after 1m0s
[14:39:09.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:49:0)
[14:39:09.810] Timer tick, asking Buildbucket for the build status
[14:39:09.895] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:09.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:50:0) after 1m0s
[14:40:09.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:50:0)
[14:40:09.937] Timer tick, asking Buildbucket for the build status
[14:40:10.041] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:10.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:51:0) after 1m0s
[14:41:10.089] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:51:0)
[14:41:10.089] Timer tick, asking Buildbucket for the build status
[14:41:10.345] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:10.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:52:0) after 1m0s
[14:42:12.222] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:52:0)
[14:42:12.222] Timer tick, asking Buildbucket for the build status
[14:42:12.611] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:12.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:53:0) after 1m0s
[14:43:12.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:53:0)
[14:43:12.672] Timer tick, asking Buildbucket for the build status
[14:43:12.798] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:12.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:54:0) after 1m0s
[14:44:12.830] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:54:0)
[14:44:12.830] Timer tick, asking Buildbucket for the build status
[14:44:12.926] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:12.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:55:0) after 1m0s
[14:45:13.010] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:55:0)
[14:45:13.010] Timer tick, asking Buildbucket for the build status
[14:45:13.625] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:13.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:56:0) after 1m0s
[14:46:13.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:56:0)
[14:46:13.621] Timer tick, asking Buildbucket for the build status
[14:46:13.675] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:13.675] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:57:0) after 1m0s
[14:47:13.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:57:0)
[14:47:13.732] Timer tick, asking Buildbucket for the build status
[14:47:14.127] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:14.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:58:0) after 1m0s
[14:48:14.249] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:58:0)
[14:48:14.249] Timer tick, asking Buildbucket for the build status
[14:48:14.404] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:14.404] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:59:0) after 1m0s
[14:49:14.469] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:59:0)
[14:49:14.469] Timer tick, asking Buildbucket for the build status
[14:49:14.622] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:14.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:60:0) after 1m0s
[14:50:14.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:60:0)
[14:50:14.632] Timer tick, asking Buildbucket for the build status
[14:50:14.725] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:14.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:61:0) after 1m0s
[14:51:14.789] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:61:0)
[14:51:14.789] Timer tick, asking Buildbucket for the build status
[14:51:14.919] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:14.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:62:0) after 1m0s
[14:52:14.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:62:0)
[14:52:14.963] Timer tick, asking Buildbucket for the build status
[14:52:15.049] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:15.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:63:0) after 1m0s
[14:53:15.151] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:63:0)
[14:53:15.151] Timer tick, asking Buildbucket for the build status
[14:53:15.302] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:15.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:64:0) after 1m0s
[14:54:15.356] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:64:0)
[14:54:15.356] Timer tick, asking Buildbucket for the build status
[14:54:15.447] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:15.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:65:0) after 1m0s
[14:55:15.500] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:65:0)
[14:55:15.500] Timer tick, asking Buildbucket for the build status
[14:55:15.615] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:15.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:66:0) after 1m0s
[14:56:15.652] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:66:0)
[14:56:15.652] Timer tick, asking Buildbucket for the build status
[14:56:15.718] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:15.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:67:0) after 1m0s
[14:57:15.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:67:0)
[14:57:15.869] Timer tick, asking Buildbucket for the build status
[14:57:16.121] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:16.121] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:68:0) after 1m0s
[14:58:16.264] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:68:0)
[14:58:16.264] Timer tick, asking Buildbucket for the build status
[14:58:16.337] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:16.337] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:69:0) after 1m0s
[14:59:16.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:69:0)
[14:59:16.352] Timer tick, asking Buildbucket for the build status
[14:59:16.452] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:16.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:70:0) after 1m0s
[15:00:16.431] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:70:0)
[15:00:16.431] Timer tick, asking Buildbucket for the build status
[15:00:16.586] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:16.586] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:71:0) after 1m0s
[15:01:17.060] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:71:0)
[15:01:17.061] Timer tick, asking Buildbucket for the build status
[15:01:17.272] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:17.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:72:0) after 1m0s
[15:02:17.430] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:72:0)
[15:02:17.430] Timer tick, asking Buildbucket for the build status
[15:02:17.843] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:17.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:73:0) after 1m0s
[15:03:17.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:73:0)
[15:03:17.944] Timer tick, asking Buildbucket for the build status
[15:03:18.327] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:18.327] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:74:0) after 1m0s
[15:04:18.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:74:0)
[15:04:18.511] Timer tick, asking Buildbucket for the build status
[15:04:18.728] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:18.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:75:0) after 1m0s
[15:05:18.768] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:75:0)
[15:05:18.768] Timer tick, asking Buildbucket for the build status
[15:05:18.854] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:18.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:76:0) after 1m0s
[15:06:18.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:76:0)
[15:06:18.872] Timer tick, asking Buildbucket for the build status
[15:06:19.115] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:19.115] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:77:0) after 1m0s
[15:07:19.211] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:77:0)
[15:07:19.211] Timer tick, asking Buildbucket for the build status
[15:07:19.871] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:19.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:78:0) after 1m0s
[15:08:19.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:78:0)
[15:08:19.992] Timer tick, asking Buildbucket for the build status
[15:08:21.761] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:21.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:79:0) after 1m0s
[15:09:21.781] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:79:0)
[15:09:21.781] Timer tick, asking Buildbucket for the build status
[15:09:21.876] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:21.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:80:0) after 1m0s
[15:10:21.898] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:80:0)
[15:10:21.898] Timer tick, asking Buildbucket for the build status
[15:10:22.223] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:22.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:81:0) after 1m0s
[15:11:22.235] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:81:0)
[15:11:22.235] Timer tick, asking Buildbucket for the build status
[15:11:22.313] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:22.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:82:0) after 1m0s
[15:12:22.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:82:0)
[15:12:22.324] Timer tick, asking Buildbucket for the build status
[15:12:22.614] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:22.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:83:0) after 1m0s
[15:13:22.657] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:83:0)
[15:13:22.657] Timer tick, asking Buildbucket for the build status
[15:13:22.721] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:22.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:84:0) after 1m0s
[15:14:22.762] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:84:0)
[15:14:22.762] Timer tick, asking Buildbucket for the build status
[15:14:22.897] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:22.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:85:0) after 1m0s
[15:15:22.911] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:85:0)
[15:15:22.911] Timer tick, asking Buildbucket for the build status
[15:15:22.968] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:22.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:86:0) after 1m0s
[15:16:23.100] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:86:0)
[15:16:23.100] Timer tick, asking Buildbucket for the build status
[15:16:23.710] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:23.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:87:0) after 1m0s
[15:17:23.761] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:87:0)
[15:17:23.761] Timer tick, asking Buildbucket for the build status
[15:17:23.935] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:23.935] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:88:0) after 1m0s
[15:18:23.943] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:88:0)
[15:18:23.943] Timer tick, asking Buildbucket for the build status
[15:18:24.114] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:24.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:89:0) after 1m0s
[15:19:24.146] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:89:0)
[15:19:24.146] Timer tick, asking Buildbucket for the build status
[15:19:24.243] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:24.243] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:90:0) after 1m0s
[15:20:24.285] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:90:0)
[15:20:24.285] Timer tick, asking Buildbucket for the build status
[15:20:24.343] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:24.343] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:91:0) after 1m0s
[15:21:24.391] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:91:0)
[15:21:24.391] Timer tick, asking Buildbucket for the build status
[15:21:24.666] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:24.666] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:92:0) after 1m0s
[15:22:24.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:92:0)
[15:22:24.825] Timer tick, asking Buildbucket for the build status
[15:22:25.100] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:25.100] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:93:0) after 1m0s
[15:23:25.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:93:0)
[15:23:25.157] Timer tick, asking Buildbucket for the build status
[15:23:26.099] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:26.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:94:0) after 1m0s
[15:24:26.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:94:0)
[15:24:26.125] Timer tick, asking Buildbucket for the build status
[15:24:26.195] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:26.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:95:0) after 1m0s
[15:25:26.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:95:0)
[15:25:26.289] Timer tick, asking Buildbucket for the build status
[15:25:26.444] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:26.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:96:0) after 1m0s
[15:26:26.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:96:0)
[15:26:26.459] Timer tick, asking Buildbucket for the build status
[15:26:26.822] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:26.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:97:0) after 1m0s
[15:27:26.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:97:0)
[15:27:26.845] Timer tick, asking Buildbucket for the build status
[15:27:27.310] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:27.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:98:0) after 1m0s
[15:28:27.468] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:98:0)
[15:28:27.468] Timer tick, asking Buildbucket for the build status
[15:28:27.819] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:27.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:99:0) after 1m0s
[15:29:27.812] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:99:0)
[15:29:27.812] Timer tick, asking Buildbucket for the build status
[15:29:27.911] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:27.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:100:0) after 1m0s
[15:30:27.988] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:100:0)
[15:30:27.988] Timer tick, asking Buildbucket for the build status
[15:30:28.201] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:28.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:101:0) after 1m0s
[15:31:28.222] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:101:0)
[15:31:28.222] Timer tick, asking Buildbucket for the build status
[15:31:28.334] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:28.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:102:0) after 1m0s
[15:32:28.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:102:0)
[15:32:28.373] Timer tick, asking Buildbucket for the build status
[15:32:28.563] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:28.563] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:103:0) after 1m0s
[15:33:28.633] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:103:0)
[15:33:28.633] Timer tick, asking Buildbucket for the build status
[15:33:29.127] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:29.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:104:0) after 1m0s
[15:34:29.252] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:104:0)
[15:34:29.252] Timer tick, asking Buildbucket for the build status
[15:34:29.325] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:29.325] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:105:0) after 1m0s
[15:35:29.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:105:0)
[15:35:29.350] Timer tick, asking Buildbucket for the build status
[15:35:29.517] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:29.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:106:0) after 1m0s
[15:36:29.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:106:0)
[15:36:29.550] Timer tick, asking Buildbucket for the build status
[15:36:29.703] Build 8856039600451994032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:29.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021469662363730720:107:0) after 1m0s
[15:37:28.987] Received PubSub notification, asking Buildbucket for the build status
[15:37:29.212] Build 8856039600451994032: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:37:29.212] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612625847457370",
"created_by": "project:chromium",
"created_ts": "1612619510180738",
"id": "8856039600451994032",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"20f315408a4f49da7896b69c4be90dbc5d984eea\"}}",
"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\": \"20f315408a4f49da7896b69c4be90dbc5d984eea\", \"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-90-clxi\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180336, \"got_angle_revision\": \"0bb520adffe41d0f2007c4fe7fdf5754d2939a1d\", \"got_dawn_revision\": \"2831f0584028114a8896059ce00e7bddaf3bba1f\", \"got_nacl_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"got_revision\": \"20f315408a4f49da7896b69c4be90dbc5d984eea\", \"got_revision_cp\": \"refs/heads/master@{#851468}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"266614a36dbd5328a9079ea6bbef9026c7bbe3d7\", \"got_v8_revision\": \"711403215714087a74f05b1382b18e4c318be936\", \"got_v8_revision_cp\": \"refs/heads/9.0.137@{#1}\", \"got_webrtc_revision\": \"129caca888ed9ef06668ed990a537b368e6c6dcb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33182}\", \"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\": \"20f315408a4f49da7896b69c4be90dbc5d984eea\", \"swarm_hashes_refs/heads/master(at){#851468}_without_patch\": {\"absl_hardening_tests\": \"196cf76f98cb8b4fd83388166a04b14eca35589c\", \"accessibility_unittests\": \"b66bc34ea5c9082df0e44881f8c78e436e3e85ee\", \"angle_unittests\": \"c00044e59033f17e0e669d899793b121c44cc7d3\", \"app_shell_unittests\": \"eef8cdd1870f18cc961875619dd8bf177f8434fc\", \"aura_unittests\": \"8b455015eda40e32bf908ed2a821bd09d5981665\", \"base_unittests\": \"256c388fff573a7271226e8b9dcee867649500da\", \"base_util_unittests\": \"76060a99d12485b1cc7371d438f88b3519260c9a\", \"blink_common_unittests\": \"b0f7726ffa4404b6bdaeaf6db1fadc58ccce3a7c\", \"blink_fuzzer_unittests\": \"88904875cda59d01b97a384f4c7f251b28123b13\", \"blink_heap_unittests\": \"172eaa5777700f1a177908d947427c26714d9bcf\", \"blink_platform_unittests\": \"a45f5a63f3f207333dfde05da3781112681c0392\", \"blink_python_tests\": \"3fee940019a74843b7b678382a7a94dcff347e7b\", \"blink_unittests\": \"57bd2a91b97dee17da76d7f75227155580fce70c\", \"blink_web_tests\": \"dca87ea49dddb6cb9d7285275025a3b8180d7586\", \"boringssl_crypto_tests\": \"99ccb3afb586470cfeb62d7fd16b31a5fe79ecac\", \"boringssl_ssl_tests\": \"12511a77a1a96a18be44eb95a959a10e8c9cd426\", \"browser_tests\": \"15954afb46c0cf36a97b3fada1e4c5e85fc8c774\", \"capture_unittests\": \"9cb86f5c34b03d5b31aaee3514132bf5978ae539\", \"cast_unittests\": \"553b7630c265c5ffe44a255f618516ed54e922e3\", \"cc_unittests\": \"aba553e13df43603b7607a73e92a524f68595ae5\", \"chrome_app_unittests\": \"c194a1960bc5db952d0a758ec3a0237c8a95b466\", \"chromedriver_unittests\": \"42787c460a8c78ae18df1bc111b50b4b8004babb\", \"components_browsertests\": \"ee7d570e66cc0e75fdafd230ce77c1a54ac12c63\", \"components_unittests\": \"542912b8785ac6deaea345fc90ed0aa1e027de94\", \"compositor_unittests\": \"cb1893e9912b31a5e794207cd3852a497b2e5452\", \"content_browsertests\": \"4c3bbbf4e08df729c1ba40bc9905d214c84fd006\", \"content_shell_crash_test\": \"5fc94dac9b625cc6d22b2bd32477aaff83c0f11e\", \"content_unittests\": \"2688c71731a29fab2f3405f1a6214e8ffd183c4a\", \"crashpad_tests\": \"acdc20a662452bc1eb79362d36827b1d5784f9d9\", \"cronet_tests\": \"92322847f2fb2d96bd02a067eade9b775b8eb30b\", \"cronet_unittests\": \"d86eebb662504117af61f4cdee65ada2e6f04c6c\", \"crypto_unittests\": \"ad4c48c59681ddd5d7784f00e53701ea392059e9\", \"dbus_unittests\": \"404ae7b192f2ea686ff5483493b2c622dbb7f628\", \"device_unittests\": \"5a9c0f521dce45ddb442ff0ca8245f53256453a5\", \"display_unittests\": \"eb730d6108150ec3a4570b44ba58cbc821bfeee5\", \"events_unittests\": \"15f4966400e159636f57b968aa219c0d89e5416b\", \"extensions_browsertests\": \"039959b89ec57c7e077bf4e0cddab0ad23091e4d\", \"extensions_unittests\": \"4d813b176c3d2bad3dda4d01726e2c32ccf449a3\", \"filesystem_service_unittests\": \"66e4a042fa3eccf26f57cb5ab3fb4c4397511c79\", \"flatbuffers_unittests\": \"adcf587971a832b1be93c24a83cd1ec975e593d8\", \"gcm_unit_tests\": \"5d8a8b07e793e8da78d9e2b8e3e738e28003b1ca\", \"gfx_unittests\": \"5c5a3391b35309e7a2cf053ac67ad68439673b3e\", \"gin_unittests\": \"4e17042a398a2e19de35b554463a71dde1b5362c\", \"google_apis_unittests\": \"c79ce28c24c685f9275dba21d9f8519918f55580\", \"gpu_unittests\": \"bdd7abbed8ce3106e92aae27bc840af9a83877a6\", \"grit_python_unittests\": \"09d11eaebf65aefde13fcafc2a12fe42d6476e6b\", \"gwp_asan_unittests\": \"a455a6d1379e74ab2a9fdd02224b4ed6bb8fea72\", \"headless_browsertests\": \"18ac6162a887e53c231ba24c5b07472e2b235af9\", \"headless_unittests\": \"e730b131ac10d4bb9c5b04fd557dd64dcc1adf44\", \"interactive_ui_tests\": \"ea6414a4461e1e3d7af622b4d46b9cd404520e1c\", \"ipc_tests\": \"3f3f207ed9582b98c0ba8a7e8002b300694aa4d9\", \"jingle_unittests\": \"b9e3019a608d10e747611361747bbff093146c12\", \"latency_unittests\": \"7622ef227290fa932437c7129f170b8b23efe595\", \"libjingle_xmpp_unittests\": \"e1c290cbf5f3b0f28ffd0be16c8efa8acd403f85\", \"liburlpattern_unittests\": \"3362809624b2d0396cedb6b5fc599c25b58b5308\", \"media_blink_unittests\": \"e7c151cd5ccbfc10aae8e2263f7ff3f1fc75e043\", \"media_unittests\": \"d01c668add7fd80e6930417cb09fa4c39484e921\", \"message_center_unittests\": \"daa6bba61e654a49f27e8cd82b716008a64c1b9f\", \"metrics_python_tests\": \"3af7da07ea324fe9bd3ce36ef6f07fe4928b4065\", \"midi_unittests\": \"8ee6a2994b99525b406b5d30a4398c2f28fa5771\", \"mojo_core_unittests\": \"4bcb947a68437388c24d923c7c0f1ae89280d4dd\", \"mojo_unittests\": \"5171fef4430195df764d240220d8f5433e155438\", \"nacl_helper_nonsfi_unittests\": \"3b7ff7e57f7c30f9fc79b7ebda339b007ed1c572\", \"nacl_loader_unittests\": \"994c9f8f42806e8e1a8afc6086cdd2092c0d534e\", \"native_theme_unittests\": \"1dbd7b5a7b72a1f5cd85015a019ae011257a36b9\", \"net_unittests\": \"6e8c67c68c3a0fb66d48e25b7716a24c03a3e456\", \"openscreen_unittests\": \"d6c3626c51077ac104d59dab34894ad9b51c7976\", \"pdf_unittests\": \"8542619813fe05856d30f768a4f1358cd92d2468\", \"perfetto_unittests\": \"fa7c371753989adc94c7cf9640b3b007ec6dba55\", \"ppapi_unittests\": \"d53607208a4626fead61cb0fe480d5f81ae63c93\", \"printing_unittests\": \"e35021c819f2c183ea5e356d89d0050174a8d815\", \"remoting_unittests\": \"563b688a0b066d3ba8b6ff267d622fb5559c076d\", \"sandbox_linux_unittests\": \"22975730c7b2ff3da302c65f0de7ccd4402f8cde\", \"service_manager_unittests\": \"f993d941c73efb9d7dd2b5bb9e4cac2a4f1be536\", \"services_unittests\": \"960eafe48ddb2b35d4f0f5ffded6899dee4b4223\", \"shell_dialogs_unittests\": \"cbf8e91e4ab4718f1a64c4ec7afc315c4651de9e\", \"skia_unittests\": \"c84e6587205be0fd9b9968b71e99d44c2a44082c\", \"snapshot_unittests\": \"b15ebcf9b5698a01762eb5880b4f6466b2166cbc\", \"sql_unittests\": \"1ed1e74d5bda4749aa4a11a5d5defbaa78d200d2\", \"storage_unittests\": \"06df0e5d416ba5303a9a3bff080ea0d45cb440ba\", \"sync_integration_tests\": \"f6a6359519af126c680791936ec4f54174aa1880\", \"telemetry_gpu_unittests\": \"ac7aad644ed79afcf25e0fe66dae1eaae560c0e2\", \"telemetry_perf_unittests\": \"8af255f1c4c6c93016ea97331890ffe19a96cb5a\", \"telemetry_unittests\": \"80773aed3e898f8fffdded561975215c8c4ebee7\", \"traffic_annotation_auditor_unittests\": \"0163df4c511ed68f8d2bbd4436cced7281a44ee1\", \"ui_base_unittests\": \"7abed2ed6957d2278ec36b161e176097486da8b0\", \"ui_touch_selection_unittests\": \"875855a16c398f7d7def7e4ac96f12528ef63635\", \"unit_tests\": \"671d794f16a491fe3abf3b861557e728d20a01d3\", \"url_unittests\": \"2f699a44f42f2c8ec4cb72603dcc9cbb7949bb26\", \"views_perftests\": \"778a859e2013ee9610a6f23ac5e6001b4150bda4\", \"views_unittests\": \"14f82e9fce3ae47a1e0545af419587d23d08ec8b\", \"viz_unittests\": \"efbdc0b2c0b3ca0acd0d4c93a69b617a3d002360\", \"vr_common_unittests\": \"a9d099b2d98b4445b54df65c11181b423c3286a1\", \"vr_pixeltests\": \"e1a02f9995092b1b7e056f9515cef27d39fcbf96\", \"webdriver_wpt_tests\": \"0a696c735c3ed08a2032220b0668196a60c81d56\", \"weblayer_browsertests\": \"2e425f789c91654efe77b4753eae39b1b87878a4\", \"weblayer_unittests\": \"e9562fb35fd554e3bde2ad5679b7c5a5117639d5\", \"wm_unittests\": \"e0b787ebb74a4794f560ac60f6be119e6c3a36f0\", \"wtf_unittests\": \"ced19995ecf3a4c1a5cb029f0b2037c0b17c715f\", \"x11_unittests\": \"02795412363d03473f89229fb9f2cf71552b04d5\", \"xr_browser_tests\": \"c1a8a9b6f32190031e68dfec96085ba0020a211b\", \"zlib_unittests\": \"bda437db70d9f07866b9c16a1b9625599796e2bc\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1baf36be136c6e37e5283db20727ce1fca753922b4729c01ac3834cd33897d7d_v2\", \"builder_62c898de6588ca5d707c8045ecb6f8a7746948ea4311f8836fa952d6f41dbc73_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_a1c3d05f1886c3c1a4b693e8245da857a9c63a0cda58ad280c9a386162f50760_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"builder_ce22d0fc5c297d03141230de59f52ebaf9005395a667e8b14df59e499796620f_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-90-clxi\"], \"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\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612621864314163",
"status": "COMPLETED",
"status_changed_ts": "1612625848532788",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180336",
"builder:Linux Builder (dbg)",
"buildset:commit/git/20f315408a4f49da7896b69c4be90dbc5d984eea",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/20f315408a4f49da7896b69c4be90dbc5d984eea",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021469662363730720",
"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/8856039600451994032/+/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:51906e7c76e0da10",
"user_agent:luci-scheduler"
],
"updated_ts": "1612625848616752",
"url": "https://ci.chromium.org/b/8856039600451994032",
"utcnow_ts": "1612625849194019"
}
}
[15:37:29.212] Invocation finished in 1h45m40.238689028s with status SUCCEEDED