[22:21:08.940] New invocation is queued and will start shortly
[22:21:10.000] Starting the invocation (attempt 1)
[22:21:10.036] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:21:10.036] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:21:10.036] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025786272319157568",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"52cc383aa67c9a5ff7409e77d62d60be9919c578\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9025786272319157568",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/52cc383aa67c9a5ff7409e77d62d60be9919c578",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52cc383aa67c9a5ff7409e77d62d60be9919c578",
"gitiles_ref:refs/heads/master"
]
}
[22:21:10.938] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608502870138828",
"id": "8860356210400182512",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"52cc383aa67c9a5ff7409e77d62d60be9919c578\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608502870818990",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178846",
"builder:Linux Builder (dbg)",
"buildset:commit/git/52cc383aa67c9a5ff7409e77d62d60be9919c578",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52cc383aa67c9a5ff7409e77d62d60be9919c578",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025786272319157568",
"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/8860356210400182512/+/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": "1608502870819546",
"url": "https://ci.chromium.org/b/8860356210400182512",
"utcnow_ts": "1608502870930818"
}
}
[22:21:10.938] Task URL: https://ci.chromium.org/b/8860356210400182512
[22:21:10.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:2:0) after 1m0s
[22:22:11.151] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:2:0)
[22:22:11.151] Timer tick, asking Buildbucket for the build status
[22:22:11.420] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:22:11.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:3:0) after 1m0s
[22:23:11.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:3:0)
[22:23:11.421] Timer tick, asking Buildbucket for the build status
[22:23:11.489] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:23:11.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:4:0) after 1m0s
[22:24:11.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:4:0)
[22:24:11.541] Timer tick, asking Buildbucket for the build status
[22:24:11.603] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:24:11.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:5:0) after 1m0s
[22:25:11.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:5:0)
[22:25:11.642] Timer tick, asking Buildbucket for the build status
[22:25:11.729] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:25:11.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:6:0) after 1m0s
[22:26:11.770] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:6:0)
[22:26:11.770] Timer tick, asking Buildbucket for the build status
[22:26:12.102] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:26:12.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:7:0) after 1m0s
[22:27:12.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:7:0)
[22:27:12.128] Timer tick, asking Buildbucket for the build status
[22:27:12.193] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:27:12.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:8:0) after 1m0s
[22:28:12.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:8:0)
[22:28:12.334] Timer tick, asking Buildbucket for the build status
[22:28:12.467] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:28:12.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:9:0) after 1m0s
[22:29:12.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:9:0)
[22:29:12.617] Timer tick, asking Buildbucket for the build status
[22:29:13.008] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:29:13.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:10:0) after 1m0s
[22:30:13.235] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:10:0)
[22:30:13.235] Timer tick, asking Buildbucket for the build status
[22:30:13.423] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:30:13.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:11:0) after 1m0s
[22:31:13.501] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:11:0)
[22:31:13.501] Timer tick, asking Buildbucket for the build status
[22:31:13.874] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:31:13.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:12:0) after 1m0s
[22:32:14.037] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:12:0)
[22:32:14.037] Timer tick, asking Buildbucket for the build status
[22:32:14.101] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:32:14.101] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:13:0) after 1m0s
[22:33:14.171] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:13:0)
[22:33:14.171] Timer tick, asking Buildbucket for the build status
[22:33:14.237] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:33:14.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:14:0) after 1m0s
[22:34:14.365] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:14:0)
[22:34:14.365] Timer tick, asking Buildbucket for the build status
[22:34:14.438] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:34:14.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:15:0) after 1m0s
[22:35:14.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:15:0)
[22:35:14.441] Timer tick, asking Buildbucket for the build status
[22:35:14.512] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:35:14.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:16:0) after 1m0s
[22:36:14.574] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:16:0)
[22:36:14.574] Timer tick, asking Buildbucket for the build status
[22:36:14.979] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:36:14.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:17:0) after 1m0s
[22:37:15.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:17:0)
[22:37:15.048] Timer tick, asking Buildbucket for the build status
[22:37:15.116] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:37:15.116] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:18:0) after 1m0s
[22:38:15.172] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:18:0)
[22:38:15.172] Timer tick, asking Buildbucket for the build status
[22:38:15.241] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:38:15.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:19:0) after 1m0s
[22:39:15.308] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:19:0)
[22:39:15.308] Timer tick, asking Buildbucket for the build status
[22:39:15.565] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:39:15.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:20:0) after 1m0s
[22:40:15.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:20:0)
[22:40:15.589] Timer tick, asking Buildbucket for the build status
[22:40:15.929] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:40:15.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:21:0) after 1m0s
[22:41:15.945] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:21:0)
[22:41:15.945] Timer tick, asking Buildbucket for the build status
[22:41:16.118] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:41:16.118] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:22:0) after 1m0s
[22:42:16.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:22:0)
[22:42:16.166] Timer tick, asking Buildbucket for the build status
[22:42:16.233] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:42:16.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:23:0) after 1m0s
[22:43:16.249] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:23:0)
[22:43:16.249] Timer tick, asking Buildbucket for the build status
[22:43:16.319] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:43:16.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:24:0) after 1m0s
[22:44:16.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:24:0)
[22:44:16.341] Timer tick, asking Buildbucket for the build status
[22:44:16.425] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:44:16.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:25:0) after 1m0s
[22:45:16.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:25:0)
[22:45:16.481] Timer tick, asking Buildbucket for the build status
[22:45:16.543] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:16.543] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:26:0) after 1m0s
[22:46:16.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:26:0)
[22:46:16.573] Timer tick, asking Buildbucket for the build status
[22:46:16.809] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:16.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:27:0) after 1m0s
[22:47:16.874] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:27:0)
[22:47:16.874] Timer tick, asking Buildbucket for the build status
[22:47:16.941] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:16.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:28:0) after 1m0s
[22:48:17.051] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:28:0)
[22:48:17.051] Timer tick, asking Buildbucket for the build status
[22:48:17.287] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:17.287] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:29:0) after 1m0s
[22:49:17.309] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:29:0)
[22:49:17.309] Timer tick, asking Buildbucket for the build status
[22:49:17.373] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:17.373] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:30:0) after 1m0s
[22:50:17.385] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:30:0)
[22:50:17.385] Timer tick, asking Buildbucket for the build status
[22:50:17.558] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:17.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:31:0) after 1m0s
[22:51:17.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:31:0)
[22:51:17.627] Timer tick, asking Buildbucket for the build status
[22:51:17.708] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:17.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:32:0) after 1m0s
[22:52:17.734] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:32:0)
[22:52:17.734] Timer tick, asking Buildbucket for the build status
[22:52:17.822] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:17.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:33:0) after 1m0s
[22:53:17.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:33:0)
[22:53:17.859] Timer tick, asking Buildbucket for the build status
[22:53:18.111] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:18.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:34:0) after 1m0s
[22:54:18.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:34:0)
[22:54:18.134] Timer tick, asking Buildbucket for the build status
[22:54:18.197] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:18.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:35:0) after 1m0s
[22:55:18.219] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:35:0)
[22:55:18.219] Timer tick, asking Buildbucket for the build status
[22:55:18.426] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:18.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:36:0) after 1m0s
[22:56:18.504] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:36:0)
[22:56:18.504] Timer tick, asking Buildbucket for the build status
[22:56:18.577] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:18.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:37:0) after 1m0s
[22:57:18.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:37:0)
[22:57:18.617] Timer tick, asking Buildbucket for the build status
[22:57:18.701] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:18.701] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:38:0) after 1m0s
[22:58:18.728] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:38:0)
[22:58:18.728] Timer tick, asking Buildbucket for the build status
[22:58:18.788] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:18.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:39:0) after 1m0s
[22:59:18.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:39:0)
[22:59:18.959] Timer tick, asking Buildbucket for the build status
[22:59:19.034] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:19.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:40:0) after 1m0s
[23:00:19.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:40:0)
[23:00:19.136] Timer tick, asking Buildbucket for the build status
[23:00:19.224] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:19.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:41:0) after 1m0s
[23:01:19.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:41:0)
[23:01:19.299] Timer tick, asking Buildbucket for the build status
[23:01:19.445] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:19.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:42:0) after 1m0s
[23:02:19.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:42:0)
[23:02:19.516] Timer tick, asking Buildbucket for the build status
[23:02:20.093] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:20.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:43:0) after 1m0s
[23:03:20.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:43:0)
[23:03:20.157] Timer tick, asking Buildbucket for the build status
[23:03:20.232] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:20.232] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:44:0) after 1m0s
[23:04:20.305] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:44:0)
[23:04:20.305] Timer tick, asking Buildbucket for the build status
[23:04:20.560] Build 8860356210400182512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:20.560] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:45:0) after 1m0s
[23:04:29.276] Received PubSub notification, asking Buildbucket for the build status
[23:04:29.339] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:20.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:45:0)
[23:05:20.598] Timer tick, asking Buildbucket for the build status
[23:05:20.738] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:20.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:47:0) after 1m0s
[23:06:20.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:47:0)
[23:06:20.804] Timer tick, asking Buildbucket for the build status
[23:06:21.006] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:21.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:48:0) after 1m0s
[23:07:21.037] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:48:0)
[23:07:21.037] Timer tick, asking Buildbucket for the build status
[23:07:21.097] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:21.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:49:0) after 1m0s
[23:08:21.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:49:0)
[23:08:21.106] Timer tick, asking Buildbucket for the build status
[23:08:21.157] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:21.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:50:0) after 1m0s
[23:09:21.180] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:50:0)
[23:09:21.180] Timer tick, asking Buildbucket for the build status
[23:09:21.234] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:21.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:51:0) after 1m0s
[23:10:21.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:51:0)
[23:10:21.307] Timer tick, asking Buildbucket for the build status
[23:10:21.467] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:21.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:52:0) after 1m0s
[23:11:21.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:52:0)
[23:11:21.529] Timer tick, asking Buildbucket for the build status
[23:11:21.702] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:21.702] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:53:0) after 1m0s
[23:12:21.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:53:0)
[23:12:21.732] Timer tick, asking Buildbucket for the build status
[23:12:21.837] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:21.837] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:54:0) after 1m0s
[23:13:23.611] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:54:0)
[23:13:23.611] Timer tick, asking Buildbucket for the build status
[23:13:23.666] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:23.666] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:55:0) after 1m0s
[23:14:23.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:55:0)
[23:14:23.708] Timer tick, asking Buildbucket for the build status
[23:14:23.803] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:23.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:56:0) after 1m0s
[23:15:23.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:56:0)
[23:15:23.823] Timer tick, asking Buildbucket for the build status
[23:15:24.088] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:24.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:57:0) after 1m0s
[23:16:24.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:57:0)
[23:16:24.137] Timer tick, asking Buildbucket for the build status
[23:16:24.235] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:24.235] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:58:0) after 1m0s
[23:17:24.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:58:0)
[23:17:24.289] Timer tick, asking Buildbucket for the build status
[23:17:24.411] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:24.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:59:0) after 1m0s
[23:18:24.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:59:0)
[23:18:24.481] Timer tick, asking Buildbucket for the build status
[23:18:24.669] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:24.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:60:0) after 1m0s
[23:19:24.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:60:0)
[23:19:24.682] Timer tick, asking Buildbucket for the build status
[23:19:25.153] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:25.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:61:0) after 1m0s
[23:20:25.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:61:0)
[23:20:25.192] Timer tick, asking Buildbucket for the build status
[23:20:25.400] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:25.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:62:0) after 1m0s
[23:21:25.449] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:62:0)
[23:21:25.449] Timer tick, asking Buildbucket for the build status
[23:21:25.574] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:25.574] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:63:0) after 1m0s
[23:22:25.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:63:0)
[23:22:25.698] Timer tick, asking Buildbucket for the build status
[23:22:25.760] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:25.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:64:0) after 1m0s
[23:23:25.777] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:64:0)
[23:23:25.777] Timer tick, asking Buildbucket for the build status
[23:23:25.834] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:25.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:65:0) after 1m0s
[23:24:25.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:65:0)
[23:24:25.878] Timer tick, asking Buildbucket for the build status
[23:24:25.969] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:25.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:66:0) after 1m0s
[23:25:26.024] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:66:0)
[23:25:26.024] Timer tick, asking Buildbucket for the build status
[23:25:26.079] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:26.079] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:67:0) after 1m0s
[23:26:26.098] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:67:0)
[23:26:26.098] Timer tick, asking Buildbucket for the build status
[23:26:26.212] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:26.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:68:0) after 1m0s
[23:27:26.245] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:68:0)
[23:27:26.245] Timer tick, asking Buildbucket for the build status
[23:27:26.296] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:26.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:69:0) after 1m0s
[23:28:26.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:69:0)
[23:28:26.578] Timer tick, asking Buildbucket for the build status
[23:28:26.700] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:26.700] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:70:0) after 1m0s
[23:29:26.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:70:0)
[23:29:26.875] Timer tick, asking Buildbucket for the build status
[23:29:26.940] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:26.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:71:0) after 1m0s
[23:30:27.091] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:71:0)
[23:30:27.091] Timer tick, asking Buildbucket for the build status
[23:30:27.488] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:27.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:72:0) after 1m0s
[23:31:27.587] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:72:0)
[23:31:27.587] Timer tick, asking Buildbucket for the build status
[23:31:27.678] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:27.678] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:73:0) after 1m0s
[23:32:27.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:73:0)
[23:32:27.800] Timer tick, asking Buildbucket for the build status
[23:32:27.995] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:27.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:74:0) after 1m0s
[23:33:28.148] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:74:0)
[23:33:28.148] Timer tick, asking Buildbucket for the build status
[23:33:28.199] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:28.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:75:0) after 1m0s
[23:34:28.301] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:75:0)
[23:34:28.301] Timer tick, asking Buildbucket for the build status
[23:34:28.355] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:28.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:76:0) after 1m0s
[23:35:28.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:76:0)
[23:35:28.497] Timer tick, asking Buildbucket for the build status
[23:35:28.662] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:28.662] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:77:0) after 1m0s
[23:36:28.841] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:77:0)
[23:36:28.841] Timer tick, asking Buildbucket for the build status
[23:36:28.937] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:28.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:78:0) after 1m0s
[23:37:29.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:78:0)
[23:37:29.154] Timer tick, asking Buildbucket for the build status
[23:37:29.497] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:29.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:79:0) after 1m0s
[23:38:29.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:79:0)
[23:38:29.536] Timer tick, asking Buildbucket for the build status
[23:38:29.594] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:29.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:80:0) after 1m0s
[23:39:29.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:80:0)
[23:39:29.630] Timer tick, asking Buildbucket for the build status
[23:39:29.705] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:29.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:81:0) after 1m0s
[23:40:29.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:81:0)
[23:40:29.775] Timer tick, asking Buildbucket for the build status
[23:40:29.985] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:29.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:82:0) after 1m0s
[23:41:30.058] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:82:0)
[23:41:30.058] Timer tick, asking Buildbucket for the build status
[23:41:30.513] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:30.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:83:0) after 1m0s
[23:42:30.670] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:83:0)
[23:42:30.670] Timer tick, asking Buildbucket for the build status
[23:42:30.739] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:30.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:84:0) after 1m0s
[23:43:30.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:84:0)
[23:43:30.774] Timer tick, asking Buildbucket for the build status
[23:43:30.826] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:30.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:85:0) after 1m0s
[23:44:30.947] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:85:0)
[23:44:30.947] Timer tick, asking Buildbucket for the build status
[23:44:31.010] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:31.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:86:0) after 1m0s
[23:45:31.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:86:0)
[23:45:31.032] Timer tick, asking Buildbucket for the build status
[23:45:31.126] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:31.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:87:0) after 1m0s
[23:46:31.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:87:0)
[23:46:31.328] Timer tick, asking Buildbucket for the build status
[23:46:31.516] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:31.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:88:0) after 1m0s
[23:47:31.527] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:88:0)
[23:47:31.527] Timer tick, asking Buildbucket for the build status
[23:47:31.577] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:31.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:89:0) after 1m0s
[23:48:31.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:89:0)
[23:48:31.631] Timer tick, asking Buildbucket for the build status
[23:48:31.697] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:31.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:90:0) after 1m0s
[23:49:31.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:90:0)
[23:49:31.785] Timer tick, asking Buildbucket for the build status
[23:49:31.837] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:31.837] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:91:0) after 1m0s
[23:50:31.912] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:91:0)
[23:50:31.912] Timer tick, asking Buildbucket for the build status
[23:50:31.969] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:31.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:92:0) after 1m0s
[23:51:31.998] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:92:0)
[23:51:31.998] Timer tick, asking Buildbucket for the build status
[23:51:32.111] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:32.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:93:0) after 1m0s
[23:52:32.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:93:0)
[23:52:32.166] Timer tick, asking Buildbucket for the build status
[23:52:32.219] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:32.219] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:94:0) after 1m0s
[23:53:32.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:94:0)
[23:53:32.276] Timer tick, asking Buildbucket for the build status
[23:53:32.608] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:32.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:95:0) after 1m0s
[23:54:32.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:95:0)
[23:54:32.723] Timer tick, asking Buildbucket for the build status
[23:54:32.778] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:32.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:96:0) after 1m0s
[23:55:32.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:96:0)
[23:55:32.837] Timer tick, asking Buildbucket for the build status
[23:55:32.896] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:32.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:97:0) after 1m0s
[23:56:32.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:97:0)
[23:56:32.890] Timer tick, asking Buildbucket for the build status
[23:56:33.157] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:33.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:98:0) after 1m0s
[23:57:33.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:98:0)
[23:57:33.347] Timer tick, asking Buildbucket for the build status
[23:57:33.426] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:33.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:99:0) after 1m0s
[23:58:33.471] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:99:0)
[23:58:33.471] Timer tick, asking Buildbucket for the build status
[23:58:33.520] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:33.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:100:0) after 1m0s
[23:59:33.540] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:100:0)
[23:59:33.540] Timer tick, asking Buildbucket for the build status
[23:59:33.602] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:33.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:101:0) after 1m0s
[00:00:33.647] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:101:0)
[00:00:33.647] Timer tick, asking Buildbucket for the build status
[00:00:33.729] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:33.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:102:0) after 1m0s
[00:01:33.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:102:0)
[00:01:33.732] Timer tick, asking Buildbucket for the build status
[00:01:33.969] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:33.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:103:0) after 1m0s
[00:02:34.026] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:103:0)
[00:02:34.026] Timer tick, asking Buildbucket for the build status
[00:02:34.346] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:34.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:104:0) after 1m0s
[00:03:34.472] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:104:0)
[00:03:34.472] Timer tick, asking Buildbucket for the build status
[00:03:34.548] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:34.548] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:105:0) after 1m0s
[00:04:34.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:105:0)
[00:04:34.573] Timer tick, asking Buildbucket for the build status
[00:04:34.658] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:34.658] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:106:0) after 1m0s
[00:05:34.683] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:106:0)
[00:05:34.683] Timer tick, asking Buildbucket for the build status
[00:05:34.803] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:34.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:107:0) after 1m0s
[00:06:34.965] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:107:0)
[00:06:34.965] Timer tick, asking Buildbucket for the build status
[00:06:35.522] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:35.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:108:0) after 1m0s
[00:07:35.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:108:0)
[00:07:35.549] Timer tick, asking Buildbucket for the build status
[00:07:35.599] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:35.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:109:0) after 1m0s
[00:08:35.652] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:109:0)
[00:08:35.652] Timer tick, asking Buildbucket for the build status
[00:08:35.709] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:35.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:110:0) after 1m0s
[00:09:35.771] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:110:0)
[00:09:35.771] Timer tick, asking Buildbucket for the build status
[00:09:35.824] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:35.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:111:0) after 1m0s
[00:10:35.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:111:0)
[00:10:35.863] Timer tick, asking Buildbucket for the build status
[00:10:35.911] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:35.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:112:0) after 1m0s
[00:11:35.972] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:112:0)
[00:11:35.972] Timer tick, asking Buildbucket for the build status
[00:11:36.078] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:36.078] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:113:0) after 1m0s
[00:12:36.130] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:113:0)
[00:12:36.130] Timer tick, asking Buildbucket for the build status
[00:12:36.251] Build 8860356210400182512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:36.251] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025786272319157568:114:0) after 1m0s
[00:13:18.482] Received PubSub notification, asking Buildbucket for the build status
[00:13:18.590] Build 8860356210400182512: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:13:18.590] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608509597823314",
"created_by": "project:chromium",
"created_ts": "1608502870138828",
"id": "8860356210400182512",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"52cc383aa67c9a5ff7409e77d62d60be9919c578\"}}",
"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\": \"52cc383aa67c9a5ff7409e77d62d60be9919c578\", \"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-140-s2j7\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178846, \"got_angle_revision\": \"ed9213bca0643edb65b7d39a938210419398a1b3\", \"got_dawn_revision\": \"5d4fd88a7403aa255d49919d011af54c691b344a\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"52cc383aa67c9a5ff7409e77d62d60be9919c578\", \"got_revision_cp\": \"refs/heads/master@{#838573}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"73bf5d7db9ade92643424d79b47ac70900843225\", \"got_v8_revision_cp\": \"refs/heads/8.9.178@{#1}\", \"got_webrtc_revision\": \"ef9c4e07a351c9396c72e72efaa1be3df728c440\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32863}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"52cc383aa67c9a5ff7409e77d62d60be9919c578\", \"swarm_hashes_refs/heads/master(at){#838573}_without_patch\": {\"absl_hardening_tests\": \"8f375d384e5b8a2ebdecc24bca0624147a11a2f1\", \"accessibility_unittests\": \"3c01a59a5980568d95cd98ec1a7b6ae4c8ab3d5b\", \"angle_unittests\": \"6291cbe995b57c402b427dcd62f8f6abc7b60ab2\", \"app_shell_unittests\": \"43c1d09ca078700df5316401f30aa76a538d1510\", \"aura_unittests\": \"ece65af8897fade23a1e4f7fdece6de65edbfcb7\", \"base_unittests\": \"84e09c51c834dc782a42fd6e48e3d5bdf1490201\", \"base_util_unittests\": \"84b03bad7f08af7e4c9c18e185422390f121e9d4\", \"blink_common_unittests\": \"59045cec23d5975c97931a457e724ee7894a76ac\", \"blink_fuzzer_unittests\": \"90669ac66b3f5fe91085b701a3aa9e0c1826837b\", \"blink_heap_unittests\": \"1933a18180c6d4f842b2505318047f2687cadd29\", \"blink_platform_unittests\": \"4d1bcb787969768a7113d3776b845e4305917c1e\", \"blink_python_tests\": \"a850068bffdc4a670df6ad15aeda052beec9a023\", \"blink_unittests\": \"11bc2c1dad26f3ca125cd9a023e091a2b862bab7\", \"blink_web_tests\": \"7e80016479a0f7c45a01412d318f9031e104c843\", \"boringssl_crypto_tests\": \"339c2652771d7b3e164a30240cc807aad06fc5f2\", \"boringssl_ssl_tests\": \"4125b55d8cb2aefef23667153037cfe9fe874c0e\", \"browser_tests\": \"aebec7ce4ca6287d5ffc104511a7d96863356a95\", \"capture_unittests\": \"b6086e07ea995eed4030700d065abd4a2eaa0fa2\", \"cast_unittests\": \"cbb38d0211ab9276c59f0c5288c161615136333b\", \"cc_unittests\": \"ad6418234c6b1b5c1b18bdcba8a2eaf5182617d0\", \"chrome_app_unittests\": \"a0049783878929fa7108e70c0f9e0446d052eb1d\", \"chromedriver_unittests\": \"c1458c16cc7cdbf96d798c950a4b6fd4453725f3\", \"components_browsertests\": \"6e98aec1ef45f9ead9188de23e506782a28e0674\", \"components_unittests\": \"0e9ed35d888816d80b1282b5d2f7da7968fda7cb\", \"compositor_unittests\": \"3e153d166a333d9fe3d4fca33ee3716aa7a97217\", \"content_browsertests\": \"4205f5d30656a31e561ed9c226c17d6558126caa\", \"content_shell_crash_test\": \"12eda8b7f67c9096a57d5c301052068f448508f8\", \"content_unittests\": \"30f9b0b74b8f677930f80c2dc901b592d91c355e\", \"crashpad_tests\": \"49f3237b435657bd0a41708c953bbb6e2282e049\", \"cronet_tests\": \"7ed8027278d9a58de868f6e799f05442cf33fe96\", \"cronet_unittests\": \"d6a67615f321d41768ab8feddef8bfb5b104f1c3\", \"crypto_unittests\": \"b4ea65d67dbc4046191211f280ea3161f64e3024\", \"dbus_unittests\": \"97b1705f3871e03b4dd6c1be2b4fd003b75ee19e\", \"device_unittests\": \"29eb07555b94eb2ca21d496c764ad67ad9663b17\", \"display_unittests\": \"30ea1167650ed5e6f7c5beecb9d9e0a1c15c0651\", \"events_unittests\": \"9d7d50ab12e9662ceaece244bf42bab9f401d7d7\", \"extension_docserver_python_unittests\": \"71bcd6b7573d94ae1247016c00563f0ec7b193dc\", \"extensions_browsertests\": \"d9a52cb47be0f496d3ae6002e5f2caac373d934d\", \"extensions_unittests\": \"559905bc3396ceab1762c4e03bd1be4ebb3d158d\", \"filesystem_service_unittests\": \"4632ffde0c6a59af291c8a56c844dd05e4d91d91\", \"flatbuffers_unittests\": \"d051d66da1ab229778a7e9a8f6ace686eaf5e782\", \"gcm_unit_tests\": \"44cee56f7056612bc9ee44a0bf38202b1d5df6ce\", \"gfx_unittests\": \"2b9dcbb014042f879d96752e4e64a85a8afd6d11\", \"gin_unittests\": \"38883a4b40aae4f85c18c5be854a468e2ed5456a\", \"google_apis_unittests\": \"51bf36ca78bc06d816b9b251bf51fe25578fad4f\", \"gpu_unittests\": \"b88bddf6665529ea7ef75969fb392a7ff90b28eb\", \"grit_python_unittests\": \"275c161e38b800af0a18bf8ee2ae20e83dfa4ea2\", \"gwp_asan_unittests\": \"85a4409656e25530c6e025787387b24b69465007\", \"headless_browsertests\": \"8c3982af12d495bfa2f4b9b718a0b48042ab004c\", \"headless_unittests\": \"9462d5f97ebccd4a434fbc23bdc63f4e3af76d2f\", \"interactive_ui_tests\": \"363229a6e6da52251aad1a2973cb95585bb62463\", \"ipc_tests\": \"a153841652fbf6e22b05d3e0677f03196305c049\", \"jingle_unittests\": \"c66546048253e06ea9f761619df9ab26f59416c4\", \"latency_unittests\": \"dce1126157f68b150a2eb22ee4fa2ef0f0a97f8d\", \"libjingle_xmpp_unittests\": \"892a002b30cf1f12b3008fdc93270d3bedfc9e06\", \"liburlpattern_unittests\": \"2474b765488b21a51c6bda6602ca1fc506c1de64\", \"media_blink_unittests\": \"fc95ffd606851e121b248010145dfaf10e786b8d\", \"media_unittests\": \"171893815d75a4309a2ab8ae60e86f0c4c73cec7\", \"message_center_unittests\": \"4ece78228f77b3eea83ce86bd0dc560fb4ce135b\", \"metrics_python_tests\": \"fd3a7826ddfad645365c4f3bb4d7ab34cb3be7c7\", \"midi_unittests\": \"0e00a73f893ed5495cd5f80993ab53d89adbcad8\", \"mojo_core_unittests\": \"abb7d61cbf24e8c91d09191c5de588526a852443\", \"mojo_unittests\": \"8032b62b3cfef2cc61fe3844a5ddfc949be4b65b\", \"nacl_helper_nonsfi_unittests\": \"504b27c5496dae8f718aa86efc3942da9cd9266e\", \"nacl_loader_unittests\": \"81016dd7c1f6e6fc6767c30d8e92600cc2157bdd\", \"native_theme_unittests\": \"4370d4c261fe25c03d4e4d30d76f3a4f33e0716e\", \"net_unittests\": \"ed63b978e2b48113613bbefe2bcd473d2b071a8e\", \"openscreen_unittests\": \"50904d89563cea85458ad7d138b51e1b1d474859\", \"pdf_unittests\": \"6a0c08c710c05eb4dc2f0492753371585f5b1e19\", \"perfetto_unittests\": \"2b4794f2711a3c606bb1b5db4b17b4c5bc51e90d\", \"ppapi_unittests\": \"34fdb52a7fb70fc2a97b230b9279ae2e849aae58\", \"printing_unittests\": \"2f2252e03d70b8f687fb79df98939ed8de63dbf5\", \"remoting_unittests\": \"5151152fe3778c0124578892a39e874f24661513\", \"sandbox_linux_unittests\": \"7b6c06a037257977d5ce0d7d5edadaef9eb97a47\", \"service_manager_unittests\": \"bda8e7d9dd81a88bf35a1ee16450118dc4ffcfc8\", \"services_unittests\": \"70ea251f9f0e37668b9909803d252466a4b89716\", \"shell_dialogs_unittests\": \"e2bb0d9ec4e780280f0a6ed6d519f9da5693911a\", \"skia_unittests\": \"4ad79d977d3fbdaa81120a51e9ab1b7addb58100\", \"snapshot_unittests\": \"383876e03c4fa21fbc34e22d5661362812f62ea8\", \"sql_unittests\": \"29d5e2732b97881338fedde8246ed0f24f84b4b7\", \"storage_unittests\": \"57002037533f89386dcb7cc8f3900cfd494d110c\", \"sync_integration_tests\": \"bacfcce5a6e7219bbd423a0dbf3430de7d7d9a22\", \"telemetry_gpu_unittests\": \"ca794bdf5d544b215c5f22773623b14e24e956c3\", \"telemetry_perf_unittests\": \"fc9d5c75f34d85b85d579e910ecb25dc60f7ce21\", \"telemetry_unittests\": \"1eedb6f52a9df9d9f0859103155d28f64df74a1f\", \"traffic_annotation_auditor_unittests\": \"5bc4e70c9e0e0b966adfbe4b674eb7999682a513\", \"ui_base_unittests\": \"e54cd8fac54613ffa5412088feb0bd069d35b867\", \"ui_touch_selection_unittests\": \"c0579655b924c159a29bc7db769723a2188c9685\", \"unit_tests\": \"0ceaff28e6b469689f9b204b77ebc7811cf7c186\", \"url_unittests\": \"eb4a65202e14902b6a6c737a6a15ba5786375147\", \"views_perftests\": \"b21e0b8443265442567bd53cb75542bec4558c40\", \"views_unittests\": \"215dbb99de85144c0390814606646574df99414f\", \"viz_unittests\": \"d088b29eb268c4a106a69ef5fd4832e6e6fb7f3f\", \"vr_common_unittests\": \"a8cb80f943c1c1bd61f787e1973646f36e78bfdc\", \"vr_pixeltests\": \"85ffa8c0c539ea3d9d585e271ea901eed362dc41\", \"webdriver_wpt_tests\": \"ec1513a29deb29ac6159256f5c05ed2299633b51\", \"weblayer_browsertests\": \"3c6973edb28aa053343704df308d9ff09495a48c\", \"weblayer_unittests\": \"b7b13135521c9524c79f4b3bc8596a01c2f121fc\", \"wm_unittests\": \"ea5761e0dc3e4e5c07856056e92a04abe6068ee2\", \"wtf_unittests\": \"028058b3343ce2689e518f89f06238c0146b8b5a\", \"x11_unittests\": \"72642615448c8e7f4cdba628dae26ace4d89c41e\", \"xr_browser_tests\": \"e59f5203e644756ee0d83214efaf9cd90e9c18fd\", \"zlib_unittests\": \"d7b4949fd0c0340e972b0ab41b48f91449fbaa72\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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-140-s2j7\"], \"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": "1608505451516061",
"status": "COMPLETED",
"status_changed_ts": "1608509598162341",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178846",
"builder:Linux Builder (dbg)",
"buildset:commit/git/52cc383aa67c9a5ff7409e77d62d60be9919c578",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52cc383aa67c9a5ff7409e77d62d60be9919c578",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025786272319157568",
"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/8860356210400182512/+/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:509b0f8c2ede5010",
"user_agent:luci-scheduler"
],
"updated_ts": "1608509598167821",
"url": "https://ci.chromium.org/b/8860356210400182512",
"utcnow_ts": "1608509598579150"
}
}
[00:13:18.590] Invocation finished in 1h52m9.665614386s with status SUCCEEDED