[18:04:07.448] New invocation is queued and will start shortly
[18:04:08.865] Starting the invocation (attempt 1)
[18:04:08.903] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:04:08.903] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:04:08.903] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030966470012266080",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"acfe2429e6471fad00945c78bf75e9601bc25824\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9030966470012266080",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/acfe2429e6471fad00945c78bf75e9601bc25824",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/acfe2429e6471fad00945c78bf75e9601bc25824",
"gitiles_ref:refs/heads/master"
]
}
[18:04:09.694] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603562649008005",
"id": "8865536407712021936",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"acfe2429e6471fad00945c78bf75e9601bc25824\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603562649463381",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176988",
"builder:Linux Builder (dbg)",
"buildset:commit/git/acfe2429e6471fad00945c78bf75e9601bc25824",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/acfe2429e6471fad00945c78bf75e9601bc25824",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030966470012266080",
"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/8865536407712021936/+/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": "1603562649463526",
"url": "https://ci.chromium.org/b/8865536407712021936",
"utcnow_ts": "1603562649677481"
}
}
[18:04:09.694] Task URL: https://ci.chromium.org/b/8865536407712021936
[18:04:09.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:2:0) after 1m0s
[18:05:09.767] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:2:0)
[18:05:09.767] Timer tick, asking Buildbucket for the build status
[18:05:09.946] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:05:09.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:3:0) after 1m0s
[18:06:10.057] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:3:0)
[18:06:10.057] Timer tick, asking Buildbucket for the build status
[18:06:10.148] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:06:10.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:4:0) after 1m0s
[18:07:10.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:4:0)
[18:07:10.283] Timer tick, asking Buildbucket for the build status
[18:07:10.357] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:07:10.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:5:0) after 1m0s
[18:08:10.572] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:5:0)
[18:08:10.572] Timer tick, asking Buildbucket for the build status
[18:08:10.807] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:08:10.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:6:0) after 1m0s
[18:09:10.891] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:6:0)
[18:09:10.891] Timer tick, asking Buildbucket for the build status
[18:09:10.985] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:09:10.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:7:0) after 1m0s
[18:10:11.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:7:0)
[18:10:11.262] Timer tick, asking Buildbucket for the build status
[18:10:11.494] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:10:11.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:8:0) after 1m0s
[18:11:11.531] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:8:0)
[18:11:11.531] Timer tick, asking Buildbucket for the build status
[18:11:11.608] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:11:11.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:9:0) after 1m0s
[18:12:11.737] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:9:0)
[18:12:11.737] Timer tick, asking Buildbucket for the build status
[18:12:12.043] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:12:12.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:10:0) after 1m0s
[18:13:12.186] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:10:0)
[18:13:12.186] Timer tick, asking Buildbucket for the build status
[18:13:12.315] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:13:12.315] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:11:0) after 1m0s
[18:14:12.389] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:11:0)
[18:14:12.389] Timer tick, asking Buildbucket for the build status
[18:14:12.494] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:14:12.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:12:0) after 1m0s
[18:15:12.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:12:0)
[18:15:12.507] Timer tick, asking Buildbucket for the build status
[18:15:12.596] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:15:12.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:13:0) after 1m0s
[18:16:12.745] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:13:0)
[18:16:12.745] Timer tick, asking Buildbucket for the build status
[18:16:12.813] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:16:12.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:14:0) after 1m0s
[18:17:13.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:14:0)
[18:17:13.134] Timer tick, asking Buildbucket for the build status
[18:17:13.210] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:17:13.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:15:0) after 1m0s
[18:18:13.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:15:0)
[18:18:13.299] Timer tick, asking Buildbucket for the build status
[18:18:13.385] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:18:13.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:16:0) after 1m0s
[18:19:13.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:16:0)
[18:19:13.609] Timer tick, asking Buildbucket for the build status
[18:19:13.716] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:19:13.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:17:0) after 1m0s
[18:20:13.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:17:0)
[18:20:13.893] Timer tick, asking Buildbucket for the build status
[18:20:14.198] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:20:14.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:18:0) after 1m0s
[18:21:14.348] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:18:0)
[18:21:14.348] Timer tick, asking Buildbucket for the build status
[18:21:14.429] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:21:14.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:19:0) after 1m0s
[18:22:14.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:19:0)
[18:22:14.528] Timer tick, asking Buildbucket for the build status
[18:22:14.637] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:22:14.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:20:0) after 1m0s
[18:23:14.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:20:0)
[18:23:14.723] Timer tick, asking Buildbucket for the build status
[18:23:14.827] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:23:14.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:21:0) after 1m0s
[18:24:14.887] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:21:0)
[18:24:14.887] Timer tick, asking Buildbucket for the build status
[18:24:15.095] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:24:15.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:22:0) after 1m0s
[18:25:15.119] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:22:0)
[18:25:15.119] Timer tick, asking Buildbucket for the build status
[18:25:15.197] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:25:15.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:23:0) after 1m0s
[18:26:15.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:23:0)
[18:26:15.257] Timer tick, asking Buildbucket for the build status
[18:26:15.346] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:26:15.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:24:0) after 1m0s
[18:27:15.410] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:24:0)
[18:27:15.410] Timer tick, asking Buildbucket for the build status
[18:27:15.620] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:27:15.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:25:0) after 1m0s
[18:28:15.676] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:25:0)
[18:28:15.676] Timer tick, asking Buildbucket for the build status
[18:28:15.948] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:28:15.948] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:26:0) after 1m0s
[18:29:15.996] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:26:0)
[18:29:15.996] Timer tick, asking Buildbucket for the build status
[18:29:16.120] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:29:16.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:27:0) after 1m0s
[18:30:16.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:27:0)
[18:30:16.164] Timer tick, asking Buildbucket for the build status
[18:30:16.321] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:30:16.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:28:0) after 1m0s
[18:31:16.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:28:0)
[18:31:16.324] Timer tick, asking Buildbucket for the build status
[18:31:16.397] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:31:16.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:29:0) after 1m0s
[18:32:16.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:29:0)
[18:32:16.450] Timer tick, asking Buildbucket for the build status
[18:32:16.538] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:32:16.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:30:0) after 1m0s
[18:33:16.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:30:0)
[18:33:16.598] Timer tick, asking Buildbucket for the build status
[18:33:16.677] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:33:16.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:31:0) after 1m0s
[18:34:16.767] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:31:0)
[18:34:16.767] Timer tick, asking Buildbucket for the build status
[18:34:16.883] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:34:16.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:32:0) after 1m0s
[18:35:16.877] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:32:0)
[18:35:16.877] Timer tick, asking Buildbucket for the build status
[18:35:16.975] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:35:16.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:33:0) after 1m0s
[18:36:17.107] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:33:0)
[18:36:17.107] Timer tick, asking Buildbucket for the build status
[18:36:17.201] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:36:17.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:34:0) after 1m0s
[18:37:17.195] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:34:0)
[18:37:17.195] Timer tick, asking Buildbucket for the build status
[18:37:17.423] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:37:17.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:35:0) after 1m0s
[18:38:17.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:35:0)
[18:38:17.578] Timer tick, asking Buildbucket for the build status
[18:38:17.683] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:38:17.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:36:0) after 1m0s
[18:39:17.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:36:0)
[18:39:17.714] Timer tick, asking Buildbucket for the build status
[18:39:17.806] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:39:17.806] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:37:0) after 1m0s
[18:40:17.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:37:0)
[18:40:17.859] Timer tick, asking Buildbucket for the build status
[18:40:17.990] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:40:17.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:38:0) after 1m0s
[18:41:18.010] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:38:0)
[18:41:18.010] Timer tick, asking Buildbucket for the build status
[18:41:18.080] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:41:18.080] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:39:0) after 1m0s
[18:42:18.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:39:0)
[18:42:18.105] Timer tick, asking Buildbucket for the build status
[18:42:18.269] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:42:18.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:40:0) after 1m0s
[18:43:18.288] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:40:0)
[18:43:18.288] Timer tick, asking Buildbucket for the build status
[18:43:18.365] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:43:18.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:41:0) after 1m0s
[18:44:18.391] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:41:0)
[18:44:18.391] Timer tick, asking Buildbucket for the build status
[18:44:18.499] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:44:18.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:42:0) after 1m0s
[18:45:18.640] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:42:0)
[18:45:18.640] Timer tick, asking Buildbucket for the build status
[18:45:18.712] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:45:18.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:43:0) after 1m0s
[18:46:18.877] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:43:0)
[18:46:18.877] Timer tick, asking Buildbucket for the build status
[18:46:19.122] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:46:19.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:44:0) after 1m0s
[18:47:19.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:44:0)
[18:47:19.260] Timer tick, asking Buildbucket for the build status
[18:47:19.333] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:47:19.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:45:0) after 1m0s
[18:48:19.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:45:0)
[18:48:19.473] Timer tick, asking Buildbucket for the build status
[18:48:19.555] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:48:19.555] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:46:0) after 1m0s
[18:49:19.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:46:0)
[18:49:19.664] Timer tick, asking Buildbucket for the build status
[18:49:19.777] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:49:19.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:47:0) after 1m0s
[18:50:19.858] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:47:0)
[18:50:19.858] Timer tick, asking Buildbucket for the build status
[18:50:19.977] Build 8865536407712021936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:50:19.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:48:0) after 1m0s
[18:50:29.357] Received PubSub notification, asking Buildbucket for the build status
[18:50:29.457] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:20.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:48:0)
[18:51:20.072] Timer tick, asking Buildbucket for the build status
[18:51:20.198] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:20.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:50:0) after 1m0s
[18:52:20.315] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:50:0)
[18:52:20.315] Timer tick, asking Buildbucket for the build status
[18:52:20.371] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:20.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:51:0) after 1m0s
[18:53:20.378] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:51:0)
[18:53:20.378] Timer tick, asking Buildbucket for the build status
[18:53:20.683] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:20.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:52:0) after 1m0s
[18:54:20.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:52:0)
[18:54:20.759] Timer tick, asking Buildbucket for the build status
[18:54:20.862] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:20.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:53:0) after 1m0s
[18:55:20.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:53:0)
[18:55:20.847] Timer tick, asking Buildbucket for the build status
[18:55:20.910] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:20.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:54:0) after 1m0s
[18:56:20.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:54:0)
[18:56:20.924] Timer tick, asking Buildbucket for the build status
[18:56:21.002] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:21.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:55:0) after 1m0s
[18:57:21.179] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:55:0)
[18:57:21.180] Timer tick, asking Buildbucket for the build status
[18:57:21.253] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:21.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:56:0) after 1m0s
[18:58:21.310] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:56:0)
[18:58:21.310] Timer tick, asking Buildbucket for the build status
[18:58:21.416] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:21.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:57:0) after 1m0s
[18:59:21.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:57:0)
[18:59:21.442] Timer tick, asking Buildbucket for the build status
[18:59:21.538] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:21.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:58:0) after 1m0s
[19:00:21.577] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:58:0)
[19:00:21.577] Timer tick, asking Buildbucket for the build status
[19:00:21.733] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:21.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:59:0) after 1m0s
[19:01:21.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:59:0)
[19:01:21.785] Timer tick, asking Buildbucket for the build status
[19:01:21.850] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:21.850] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:60:0) after 1m0s
[19:02:21.834] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:60:0)
[19:02:21.834] Timer tick, asking Buildbucket for the build status
[19:02:21.949] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:21.949] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:61:0) after 1m0s
[19:03:22.088] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:61:0)
[19:03:22.088] Timer tick, asking Buildbucket for the build status
[19:03:22.216] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:22.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:62:0) after 1m0s
[19:04:22.275] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:62:0)
[19:04:22.275] Timer tick, asking Buildbucket for the build status
[19:04:22.375] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:22.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:63:0) after 1m0s
[19:05:22.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:63:0)
[19:05:22.460] Timer tick, asking Buildbucket for the build status
[19:05:22.683] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:22.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:64:0) after 1m0s
[19:06:22.808] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:64:0)
[19:06:22.808] Timer tick, asking Buildbucket for the build status
[19:06:22.877] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:22.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:65:0) after 1m0s
[19:07:22.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:65:0)
[19:07:22.937] Timer tick, asking Buildbucket for the build status
[19:07:23.002] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:23.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:66:0) after 1m0s
[19:08:23.113] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:66:0)
[19:08:23.113] Timer tick, asking Buildbucket for the build status
[19:08:23.218] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:23.218] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:67:0) after 1m0s
[19:09:23.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:67:0)
[19:09:23.269] Timer tick, asking Buildbucket for the build status
[19:09:23.454] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:23.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:68:0) after 1m0s
[19:10:23.508] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:68:0)
[19:10:23.508] Timer tick, asking Buildbucket for the build status
[19:10:23.562] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:23.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:69:0) after 1m0s
[19:11:23.580] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:69:0)
[19:11:23.580] Timer tick, asking Buildbucket for the build status
[19:11:23.652] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:23.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:70:0) after 1m0s
[19:12:23.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:70:0)
[19:12:23.674] Timer tick, asking Buildbucket for the build status
[19:12:23.822] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:23.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:71:0) after 1m0s
[19:13:23.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:71:0)
[19:13:23.833] Timer tick, asking Buildbucket for the build status
[19:13:23.995] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:23.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:72:0) after 1m0s
[19:14:24.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:72:0)
[19:14:24.025] Timer tick, asking Buildbucket for the build status
[19:14:24.173] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:24.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:73:0) after 1m0s
[19:15:24.201] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:73:0)
[19:15:24.201] Timer tick, asking Buildbucket for the build status
[19:15:24.324] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:24.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:74:0) after 1m0s
[19:16:24.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:74:0)
[19:16:24.387] Timer tick, asking Buildbucket for the build status
[19:16:24.450] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:24.450] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:75:0) after 1m0s
[19:17:24.486] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:75:0)
[19:17:24.486] Timer tick, asking Buildbucket for the build status
[19:17:24.609] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:24.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:76:0) after 1m0s
[19:18:24.694] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:76:0)
[19:18:24.694] Timer tick, asking Buildbucket for the build status
[19:18:24.753] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:24.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:77:0) after 1m0s
[19:19:24.768] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:77:0)
[19:19:24.768] Timer tick, asking Buildbucket for the build status
[19:19:24.869] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:24.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:78:0) after 1m0s
[19:20:24.956] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:78:0)
[19:20:24.956] Timer tick, asking Buildbucket for the build status
[19:20:25.023] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:25.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:79:0) after 1m0s
[19:21:25.051] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:79:0)
[19:21:25.051] Timer tick, asking Buildbucket for the build status
[19:21:25.123] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:25.123] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:80:0) after 1m0s
[19:22:25.245] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:80:0)
[19:22:25.245] Timer tick, asking Buildbucket for the build status
[19:22:25.306] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:25.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:81:0) after 1m0s
[19:23:25.359] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:81:0)
[19:23:25.359] Timer tick, asking Buildbucket for the build status
[19:23:25.454] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:25.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:82:0) after 1m0s
[19:24:25.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:82:0)
[19:24:25.516] Timer tick, asking Buildbucket for the build status
[19:24:25.646] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:25.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:83:0) after 1m0s
[19:25:26.768] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:83:0)
[19:25:26.768] Timer tick, asking Buildbucket for the build status
[19:25:26.838] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:26.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:84:0) after 1m0s
[19:26:27.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:84:0)
[19:26:27.185] Timer tick, asking Buildbucket for the build status
[19:26:27.243] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:27.243] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:85:0) after 1m0s
[19:27:27.430] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:85:0)
[19:27:27.430] Timer tick, asking Buildbucket for the build status
[19:27:27.493] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:27.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:86:0) after 1m0s
[19:28:27.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:86:0)
[19:28:27.702] Timer tick, asking Buildbucket for the build status
[19:28:28.754] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:28.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:87:0) after 1m0s
[19:29:28.983] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:87:0)
[19:29:28.983] Timer tick, asking Buildbucket for the build status
[19:29:29.104] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:29.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:88:0) after 1m0s
[19:30:29.402] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:88:0)
[19:30:29.402] Timer tick, asking Buildbucket for the build status
[19:30:29.464] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:29.464] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:89:0) after 1m0s
[19:31:29.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:89:0)
[19:31:29.552] Timer tick, asking Buildbucket for the build status
[19:31:29.770] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:29.770] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:90:0) after 1m0s
[19:32:29.881] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:90:0)
[19:32:29.881] Timer tick, asking Buildbucket for the build status
[19:32:29.956] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:29.956] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:91:0) after 1m0s
[19:33:30.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:91:0)
[19:33:30.101] Timer tick, asking Buildbucket for the build status
[19:33:30.393] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:30.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:92:0) after 1m0s
[19:34:30.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:92:0)
[19:34:30.568] Timer tick, asking Buildbucket for the build status
[19:34:30.658] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:30.658] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:93:0) after 1m0s
[19:35:30.920] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:93:0)
[19:35:30.920] Timer tick, asking Buildbucket for the build status
[19:35:31.016] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:31.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:94:0) after 1m0s
[19:36:31.175] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:94:0)
[19:36:31.175] Timer tick, asking Buildbucket for the build status
[19:36:31.249] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:31.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:95:0) after 1m0s
[19:37:31.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:95:0)
[19:37:31.291] Timer tick, asking Buildbucket for the build status
[19:37:31.361] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:31.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:96:0) after 1m0s
[19:38:31.403] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:96:0)
[19:38:31.403] Timer tick, asking Buildbucket for the build status
[19:38:31.628] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:31.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:97:0) after 1m0s
[19:39:31.635] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:97:0)
[19:39:31.635] Timer tick, asking Buildbucket for the build status
[19:39:31.739] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:31.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:98:0) after 1m0s
[19:40:31.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:98:0)
[19:40:31.742] Timer tick, asking Buildbucket for the build status
[19:40:31.846] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:31.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:99:0) after 1m0s
[19:41:31.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:99:0)
[19:41:31.868] Timer tick, asking Buildbucket for the build status
[19:41:31.976] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:31.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:100:0) after 1m0s
[19:42:31.999] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:100:0)
[19:42:31.999] Timer tick, asking Buildbucket for the build status
[19:42:32.064] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:32.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:101:0) after 1m0s
[19:43:32.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:101:0)
[19:43:32.371] Timer tick, asking Buildbucket for the build status
[19:43:32.630] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:32.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:102:0) after 1m0s
[19:44:32.694] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:102:0)
[19:44:32.694] Timer tick, asking Buildbucket for the build status
[19:44:32.778] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:32.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:103:0) after 1m0s
[19:45:32.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:103:0)
[19:45:32.810] Timer tick, asking Buildbucket for the build status
[19:45:32.873] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:32.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:104:0) after 1m0s
[19:46:32.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:104:0)
[19:46:32.937] Timer tick, asking Buildbucket for the build status
[19:46:33.073] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:33.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:105:0) after 1m0s
[19:47:33.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:105:0)
[19:47:33.189] Timer tick, asking Buildbucket for the build status
[19:47:33.900] Build 8865536407712021936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:33.900] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030966470012266080:106:0) after 1m0s
[19:48:20.652] Received PubSub notification, asking Buildbucket for the build status
[19:48:21.104] Build 8865536407712021936: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:48:21.104] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603568899997869",
"created_by": "project:chromium",
"created_ts": "1603562649008005",
"id": "8865536407712021936",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"acfe2429e6471fad00945c78bf75e9601bc25824\"}}",
"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\": \"acfe2429e6471fad00945c78bf75e9601bc25824\", \"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-62-n0tx\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 176988, \"got_angle_revision\": \"7a0263547cda936b320d80c650b69d7522ee1a9f\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"acfe2429e6471fad00945c78bf75e9601bc25824\", \"got_revision_cp\": \"refs/heads/master@{#820582}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"73fe59b55662be0ff07e79da1ece8b9e42415dca\", \"got_v8_revision_cp\": \"refs/heads/8.8.171@{#1}\", \"got_webrtc_revision\": \"3065e6ef3016a906d1db82e1d4322cbd53d43247\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32481}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"acfe2429e6471fad00945c78bf75e9601bc25824\", \"swarm_hashes_refs/heads/master(at){#820582}_without_patch\": {\"absl_hardening_tests\": \"1c17c4a5b2d565f476762716571a9b32c1287718\", \"accessibility_unittests\": \"d42d133e06e7e2cad17163427a8e86a279f014bc\", \"angle_unittests\": \"fd22f1cc8f741905e23c06d57215a77c45abcdde\", \"app_shell_unittests\": \"b0949449241747764e4f9dc68a4dd4839bbdcbf7\", \"aura_unittests\": \"15cb40d2d98225207f845dce030b9894f843724e\", \"base_unittests\": \"189cf73cf30100d473037d137d378c2c8ad3e8a1\", \"base_util_unittests\": \"0ff115cd8f49f0b597fac99d8184a0c73be626d0\", \"blink_common_unittests\": \"a52e001739803a6947bf909eab539f56b378cf98\", \"blink_fuzzer_unittests\": \"76089032b3314cec620c00332525f15ce34f036b\", \"blink_heap_unittests\": \"7a0a6095c2b61a4cb56d19dbc868d8ac27c534d1\", \"blink_platform_unittests\": \"1dee5dbe67a8e8bbc2eafe88d63ab57473dac03d\", \"blink_python_tests\": \"791456e2a04922db0337876551bef069d9e92875\", \"blink_unittests\": \"a3cc5cd433151d60baa350738e2b076d18955215\", \"blink_web_tests\": \"5243e78591ce6c050b7b47fa5caa82a846da7872\", \"boringssl_crypto_tests\": \"ea945302558b6b4813f721b15822d1ab29b19eae\", \"boringssl_ssl_tests\": \"a2060d386577e378702a52fa6b70e77938de4c31\", \"browser_tests\": \"b3de8b3cd01bd4c6319cf7818a1e9d7a00d0ee81\", \"capture_unittests\": \"b92dec785269038ddb0d3807d2faf1463f071599\", \"cast_unittests\": \"efa924f3cbcfd02a5ecbed5a9bc0d32253f558b3\", \"cc_unittests\": \"3aa0ae0248dd37694afc3d9a6e531b4c562ff5c5\", \"chrome_app_unittests\": \"10dc5dc191b0a416cd7cecf178519ccdba7dff60\", \"chromedriver_unittests\": \"3bec3420df7a939cdf8cf093f1e7ae69ecd1f506\", \"components_browsertests\": \"7487dab590302d49e5972ae3ceb1565ce3e71458\", \"components_unittests\": \"557ddcd2ad959d01d4fecf3b2d3c740755525b35\", \"compositor_unittests\": \"e142b87b858e94581bee6efe91ef55184170cd83\", \"content_browsertests\": \"410f5e647792702a3f99059f5a71c58b97ef0159\", \"content_shell_crash_test\": \"8aeaa851900d38b85e61c73a54bcd7d0d7d77f76\", \"content_unittests\": \"84548793840b35e358eee5a4766d9d4a5351da91\", \"crashpad_tests\": \"fe0a20693a6cfab1685e36469b2307b1ba8c1ea4\", \"cronet_tests\": \"e28c8b4ad8b39518eebcf422ec3c3e2eb4d190bc\", \"cronet_unittests\": \"3d9d38b98ae035dad1de0ee63237cf349572297c\", \"crypto_unittests\": \"e70e21855d699a4c599c2d920cac2738bd5b4e85\", \"dbus_unittests\": \"f9e0503f65904b95f590075f7c8ead67482db969\", \"device_unittests\": \"58a2e36874866cf7d998fd17952757be1b3aa2fb\", \"display_unittests\": \"9ec1612c234da0c37b0f91a558622ccf84147a5e\", \"events_unittests\": \"cc08a334192fb3ec5a9cd992db02e5928d713640\", \"extension_docserver_python_unittests\": \"b88db22744c5ddcc424cebc58932bae058b1c7e1\", \"extensions_browsertests\": \"cf82813b286ae285624b82b8d484febb18a2b570\", \"extensions_unittests\": \"1b9481ae61ec14b2c35c775043c958028dbb254d\", \"filesystem_service_unittests\": \"b3480523b2f356d4434322781622987dde78f54a\", \"flatbuffers_unittests\": \"8004943fa766595d5f2a596771d20719dc1b1f6c\", \"gcm_unit_tests\": \"d22c2f6d2a65b19aa64901e946cd3a05b6f8aad7\", \"gfx_unittests\": \"c982cbf10c894ac0127c17ac02dd21f32dccdefc\", \"gin_unittests\": \"f8b3c4278475dd91a3db0ab5f794aa3a8946ded7\", \"google_apis_unittests\": \"6ed08badd6aaf4b86d727b9c8bed0bd049181012\", \"gpu_unittests\": \"b5db2650a2b5ff593123d16289f52faca58f840f\", \"grit_python_unittests\": \"f228d7975fe1fa8e5512e444727a70881a83f8ff\", \"gwp_asan_unittests\": \"c20288be9d3de8f1a4f2d8a018f01aacfe254941\", \"headless_browsertests\": \"b39fdb967cca1246151b575da4de308c5925706b\", \"headless_unittests\": \"60389b034ae43ae26f0ade06ba219ca6efb6653f\", \"interactive_ui_tests\": \"342cc95542e2e2092aef313f9ef1600c4dcf1d59\", \"ipc_tests\": \"4f297f726b11adfaf44bdf74cf8c6cc7388bf424\", \"jingle_unittests\": \"c3bc5095892dfe34dc52ee7ed6fb1babd99565dc\", \"latency_unittests\": \"6f7fa1ef904db5eae94724476d9c26bc7c66e403\", \"libjingle_xmpp_unittests\": \"e2fbbd844149af7ddfb9cacbff88a05c6ada4f87\", \"media_blink_unittests\": \"9930c73aa115fc0e1655640152a63ccde14d1f53\", \"media_unittests\": \"4e60b064d2c6eec16bb3fd24a5e0dee8a39652a5\", \"message_center_unittests\": \"2a302ae8e933b82d7a3d96382b1c74756c293227\", \"metrics_python_tests\": \"a34b3c3d284e153cf45ae89ddc55a9d0c03f6a73\", \"midi_unittests\": \"eaa534c42e1e0f6f9300dacbcb90b0800426d31b\", \"mojo_core_unittests\": \"3ee36566bb364c22b04576cc1f548fd1abab6ffd\", \"mojo_unittests\": \"42c51567964f7961f3c16253855cc5cc6d2a3e17\", \"nacl_helper_nonsfi_unittests\": \"cb698a546c48c7b746f45ae6910408ce67bfff47\", \"nacl_loader_unittests\": \"d69b172c2e9951f8afdac868cb83514913b8ebbd\", \"native_theme_unittests\": \"b8149dfad46a4888778cbf0eae75ab436ae17683\", \"net_unittests\": \"3a0d754bc8629303968d251625170a5a62f52f99\", \"openscreen_unittests\": \"f36b683e778ceb03ab44baf7b16f96adf59f386b\", \"pdf_unittests\": \"39594148ad08c2cd316ea914b6f594bfca128c60\", \"perfetto_unittests\": \"c1f0d4d99c0627240bfb7eae63cf8be84113660f\", \"ppapi_unittests\": \"e3e30af31a199a4a301deffe1788edb6e14df31b\", \"printing_unittests\": \"1f67cbf4b409432b9a2df5cdf64d6431f5e0ec14\", \"remoting_unittests\": \"8dbf3a76aa930444c4edf877b24441ac8dce9a7f\", \"sandbox_linux_unittests\": \"3cf23e951629578f60da82af75b6fa86777545e9\", \"service_manager_unittests\": \"126764a7babd0734973aa6503381587da240ed9a\", \"services_unittests\": \"e2bb006a6a37b44832e6c9781c99fa69f899e56d\", \"shell_dialogs_unittests\": \"5da459a139f9d81b20c061c68e850c16def971e4\", \"skia_unittests\": \"1bf2e2c3362039b78e7e5847c6501feb3de3d2cc\", \"snapshot_unittests\": \"eadd7a2c4d5ec88632bacf2c6e9fdc14b1ca4c37\", \"sql_unittests\": \"426ec95f051cac802605653d44be6ea1a7292cdf\", \"storage_unittests\": \"fa049b4cfcb3e260db78bc9dca3f6f985d1f7098\", \"sync_integration_tests\": \"d4dd046785f0f2844a722c924c86a68d62478fd7\", \"telemetry_gpu_unittests\": \"1fb45ba39a6fc0d3e2fc1f8c79cd4d74f90b9a7f\", \"telemetry_perf_unittests\": \"53d94a69d16e5e064b785b4343367e50ab5b05e4\", \"telemetry_unittests\": \"27bf6498762b051e0c76558b352240e54ceca109\", \"traffic_annotation_auditor_unittests\": \"b89f5ed83b94aae751b111c9d6db937d297d2c94\", \"ui_base_unittests\": \"196c99f3d9d13db285893b941f7b97f6cd8d149f\", \"ui_touch_selection_unittests\": \"f027a015490f26c9e9f104b7124c279841773c78\", \"unit_tests\": \"93ac37cb56fd37a2e867108e7ba27f8940731370\", \"url_unittests\": \"bcb78e1babafe643c43784f9168e81a178a177b4\", \"views_perftests\": \"b566e8c28525b06737480463e818d631209de7d8\", \"views_unittests\": \"ad9ab622c5ce4d554aabc52fe7d9f47f57242592\", \"viz_unittests\": \"5fb038b0d8f126447f868240fa2a7e71ce7bcc80\", \"vr_common_unittests\": \"4d87685fddc941be7604d71534abfb9698461930\", \"vr_pixeltests\": \"52aee806380a471df00164ee88c50d0d830e53f8\", \"webdriver_wpt_tests\": \"76fbaca070cba19c18e6b10d15d8004ce7a7cd28\", \"weblayer_browsertests\": \"655f4a87c608be4f3329197bbffb5ccc55e31d8a\", \"weblayer_unittests\": \"86606a2f1fa1e07152b31975033923acb4f99c3f\", \"wm_unittests\": \"d1eecff14ba1ecbc3ab7da066979468c64ef7fd9\", \"wtf_unittests\": \"6f69847f252047a0270ab2a61d67019035129fb5\", \"x11_unittests\": \"03a462584993542937560c756279e2ff60052342\", \"xr_browser_tests\": \"031c7a4d145710255c9ede386e344f212743cac5\", \"zlib_unittests\": \"003665500c777a238d27382c09c6e42675d29e4b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1313787165392eb219c57f145b1b9e0fbbb62d544385caa60e27617303515107_v2\", \"builder_1f6efd1a63ab00e2ded981a0276806cd2aaf7978081f3ef44b6752422059bb79_v2\", \"builder_f47d69f9f4bf9e7d220a25d2143ab9b11dd6623550a4bb4bad1124cef443bede_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-62-n0tx\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603565428335310",
"status": "COMPLETED",
"status_changed_ts": "1603568900304886",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176988",
"builder:Linux Builder (dbg)",
"buildset:commit/git/acfe2429e6471fad00945c78bf75e9601bc25824",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/acfe2429e6471fad00945c78bf75e9601bc25824",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030966470012266080",
"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/8865536407712021936/+/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:4f7499c160d7a110",
"user_agent:luci-scheduler"
],
"updated_ts": "1603568900368051",
"url": "https://ci.chromium.org/b/8865536407712021936",
"utcnow_ts": "1603568901085556"
}
}
[19:48:21.104] Invocation finished in 1h44m13.672833924s with status SUCCEEDED