[12:57:25.189] New invocation is queued and will start shortly
[12:57:26.335] Starting the invocation (attempt 1)
[12:57:26.365] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:57:26.365] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:57:26.365] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025821739095811584",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a23460e7f58da4db173cf41236206e6ff20cbf32\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9025821739095811584",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/a23460e7f58da4db173cf41236206e6ff20cbf32",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a23460e7f58da4db173cf41236206e6ff20cbf32",
"gitiles_ref:refs/heads/master"
]
}
[12:57:27.009] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608469046450633",
"id": "8860391677108002800",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a23460e7f58da4db173cf41236206e6ff20cbf32\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608469046879154",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178840",
"builder:Linux Builder (dbg)",
"buildset:commit/git/a23460e7f58da4db173cf41236206e6ff20cbf32",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a23460e7f58da4db173cf41236206e6ff20cbf32",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025821739095811584",
"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/8860391677108002800/+/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": "1608469046879264",
"url": "https://ci.chromium.org/b/8860391677108002800",
"utcnow_ts": "1608469047002955"
}
}
[12:57:27.009] Task URL: https://ci.chromium.org/b/8860391677108002800
[12:57:27.009] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:2:0) after 1m0s
[12:58:27.126] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:2:0)
[12:58:27.126] Timer tick, asking Buildbucket for the build status
[12:58:27.421] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:58:27.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:3:0) after 1m0s
[12:59:27.451] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:3:0)
[12:59:27.451] Timer tick, asking Buildbucket for the build status
[12:59:27.600] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:59:27.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:4:0) after 1m0s
[13:00:27.668] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:4:0)
[13:00:27.668] Timer tick, asking Buildbucket for the build status
[13:00:27.769] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:00:27.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:5:0) after 1m0s
[13:01:27.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:5:0)
[13:01:27.744] Timer tick, asking Buildbucket for the build status
[13:01:27.899] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:01:27.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:6:0) after 1m0s
[13:02:27.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:6:0)
[13:02:27.913] Timer tick, asking Buildbucket for the build status
[13:02:29.212] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:02:29.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:7:0) after 1m0s
[13:03:29.279] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:7:0)
[13:03:29.279] Timer tick, asking Buildbucket for the build status
[13:03:29.810] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:03:29.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:8:0) after 1m0s
[13:04:29.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:8:0)
[13:04:29.829] Timer tick, asking Buildbucket for the build status
[13:04:30.033] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:04:30.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:9:0) after 1m0s
[13:05:30.093] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:9:0)
[13:05:30.093] Timer tick, asking Buildbucket for the build status
[13:05:30.162] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:05:30.162] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:10:0) after 1m0s
[13:06:30.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:10:0)
[13:06:30.185] Timer tick, asking Buildbucket for the build status
[13:06:30.258] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:06:30.258] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:11:0) after 1m0s
[13:07:30.274] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:11:0)
[13:07:30.274] Timer tick, asking Buildbucket for the build status
[13:07:30.348] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:07:30.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:12:0) after 1m0s
[13:08:30.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:12:0)
[13:08:30.367] Timer tick, asking Buildbucket for the build status
[13:08:30.502] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:08:30.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:13:0) after 1m0s
[13:09:30.525] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:13:0)
[13:09:30.525] Timer tick, asking Buildbucket for the build status
[13:09:30.587] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:09:30.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:14:0) after 1m0s
[13:10:30.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:14:0)
[13:10:30.608] Timer tick, asking Buildbucket for the build status
[13:10:30.793] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:10:30.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:15:0) after 1m0s
[13:11:30.815] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:15:0)
[13:11:30.815] Timer tick, asking Buildbucket for the build status
[13:11:30.901] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:11:30.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:16:0) after 1m0s
[13:12:30.925] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:16:0)
[13:12:30.925] Timer tick, asking Buildbucket for the build status
[13:12:30.990] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:12:30.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:17:0) after 1m0s
[13:13:31.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:17:0)
[13:13:31.414] Timer tick, asking Buildbucket for the build status
[13:13:31.511] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:13:31.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:18:0) after 1m0s
[13:14:31.565] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:18:0)
[13:14:31.565] Timer tick, asking Buildbucket for the build status
[13:14:31.907] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:14:31.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:19:0) after 1m0s
[13:15:31.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:19:0)
[13:15:31.992] Timer tick, asking Buildbucket for the build status
[13:15:32.074] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:15:32.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:20:0) after 1m0s
[13:16:32.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:20:0)
[13:16:32.099] Timer tick, asking Buildbucket for the build status
[13:16:32.426] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:16:32.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:21:0) after 1m0s
[13:17:32.439] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:21:0)
[13:17:32.439] Timer tick, asking Buildbucket for the build status
[13:17:32.574] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:17:32.574] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:22:0) after 1m0s
[13:18:32.599] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:22:0)
[13:18:32.599] Timer tick, asking Buildbucket for the build status
[13:18:32.767] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:18:32.767] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:23:0) after 1m0s
[13:19:32.794] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:23:0)
[13:19:32.794] Timer tick, asking Buildbucket for the build status
[13:19:32.874] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:19:32.874] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:24:0) after 1m0s
[13:20:32.898] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:24:0)
[13:20:32.898] Timer tick, asking Buildbucket for the build status
[13:20:32.980] Build 8860391677108002800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:20:32.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:25:0) after 1m0s
[13:20:48.440] Received PubSub notification, asking Buildbucket for the build status
[13:20:48.507] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:33.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:25:0)
[13:21:33.106] Timer tick, asking Buildbucket for the build status
[13:21:33.193] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:33.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:27:0) after 1m0s
[13:22:33.243] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:27:0)
[13:22:33.243] Timer tick, asking Buildbucket for the build status
[13:22:33.680] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:33.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:28:0) after 1m0s
[13:23:33.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:28:0)
[13:23:33.756] Timer tick, asking Buildbucket for the build status
[13:23:33.842] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:33.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:29:0) after 1m0s
[13:24:33.949] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:29:0)
[13:24:33.949] Timer tick, asking Buildbucket for the build status
[13:24:34.025] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:34.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:30:0) after 1m0s
[13:25:34.093] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:30:0)
[13:25:34.093] Timer tick, asking Buildbucket for the build status
[13:25:34.309] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:34.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:31:0) after 1m0s
[13:26:34.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:31:0)
[13:26:34.434] Timer tick, asking Buildbucket for the build status
[13:26:34.563] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:34.563] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:32:0) after 1m0s
[13:27:34.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:32:0)
[13:27:34.685] Timer tick, asking Buildbucket for the build status
[13:27:34.740] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:34.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:33:0) after 1m0s
[13:28:34.765] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:33:0)
[13:28:34.765] Timer tick, asking Buildbucket for the build status
[13:28:34.876] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:34.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:34:0) after 1m0s
[13:29:35.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:34:0)
[13:29:35.012] Timer tick, asking Buildbucket for the build status
[13:29:35.102] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:35.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:35:0) after 1m0s
[13:30:35.184] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:35:0)
[13:30:35.184] Timer tick, asking Buildbucket for the build status
[13:30:35.425] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:35.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:36:0) after 1m0s
[13:31:35.508] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:36:0)
[13:31:35.508] Timer tick, asking Buildbucket for the build status
[13:31:35.666] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:35.666] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:37:0) after 1m0s
[13:32:35.745] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:37:0)
[13:32:35.745] Timer tick, asking Buildbucket for the build status
[13:32:35.874] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:35.874] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:38:0) after 1m0s
[13:33:35.960] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:38:0)
[13:33:35.960] Timer tick, asking Buildbucket for the build status
[13:33:36.069] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:36.069] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:39:0) after 1m0s
[13:34:36.219] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:39:0)
[13:34:36.219] Timer tick, asking Buildbucket for the build status
[13:34:36.558] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:36.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:40:0) after 1m0s
[13:35:36.555] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:40:0)
[13:35:36.555] Timer tick, asking Buildbucket for the build status
[13:35:36.694] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:36.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:41:0) after 1m0s
[13:36:36.791] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:41:0)
[13:36:36.791] Timer tick, asking Buildbucket for the build status
[13:36:36.839] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:36.839] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:42:0) after 1m0s
[13:37:36.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:42:0)
[13:37:36.929] Timer tick, asking Buildbucket for the build status
[13:37:37.129] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:37.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:43:0) after 1m0s
[13:38:37.188] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:43:0)
[13:38:37.188] Timer tick, asking Buildbucket for the build status
[13:38:37.315] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:37.315] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:44:0) after 1m0s
[13:39:37.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:44:0)
[13:39:37.372] Timer tick, asking Buildbucket for the build status
[13:39:37.434] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:37.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:45:0) after 1m0s
[13:40:37.618] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:45:0)
[13:40:37.618] Timer tick, asking Buildbucket for the build status
[13:40:37.802] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:37.802] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:46:0) after 1m0s
[13:41:37.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:46:0)
[13:41:37.864] Timer tick, asking Buildbucket for the build status
[13:41:37.990] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:37.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:47:0) after 1m0s
[13:42:38.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:47:0)
[13:42:38.498] Timer tick, asking Buildbucket for the build status
[13:42:38.571] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:38.571] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:48:0) after 1m0s
[13:43:38.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:48:0)
[13:43:38.766] Timer tick, asking Buildbucket for the build status
[13:43:38.875] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:38.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:49:0) after 1m0s
[13:44:38.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:49:0)
[13:44:38.950] Timer tick, asking Buildbucket for the build status
[13:44:39.033] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:39.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:50:0) after 1m0s
[13:45:39.113] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:50:0)
[13:45:39.113] Timer tick, asking Buildbucket for the build status
[13:45:39.184] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:39.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:51:0) after 1m0s
[13:46:39.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:51:0)
[13:46:39.417] Timer tick, asking Buildbucket for the build status
[13:46:39.474] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:39.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:52:0) after 1m0s
[13:47:39.486] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:52:0)
[13:47:39.486] Timer tick, asking Buildbucket for the build status
[13:47:39.695] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:39.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:53:0) after 1m0s
[13:48:39.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:53:0)
[13:48:39.814] Timer tick, asking Buildbucket for the build status
[13:48:40.006] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:40.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:54:0) after 1m0s
[13:49:40.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:54:0)
[13:49:40.121] Timer tick, asking Buildbucket for the build status
[13:49:40.174] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:40.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:55:0) after 1m0s
[13:50:40.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:55:0)
[13:50:40.221] Timer tick, asking Buildbucket for the build status
[13:50:40.276] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:40.276] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:56:0) after 1m0s
[13:51:40.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:56:0)
[13:51:40.347] Timer tick, asking Buildbucket for the build status
[13:51:40.406] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:40.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:57:0) after 1m0s
[13:52:40.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:57:0)
[13:52:40.560] Timer tick, asking Buildbucket for the build status
[13:52:40.611] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:40.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:58:0) after 1m0s
[13:53:40.765] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:58:0)
[13:53:40.765] Timer tick, asking Buildbucket for the build status
[13:53:41.397] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:41.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:59:0) after 1m0s
[13:54:41.633] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:59:0)
[13:54:41.633] Timer tick, asking Buildbucket for the build status
[13:54:41.694] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:41.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:60:0) after 1m0s
[13:55:41.781] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:60:0)
[13:55:41.781] Timer tick, asking Buildbucket for the build status
[13:55:41.842] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:41.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:61:0) after 1m0s
[13:56:42.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:61:0)
[13:56:42.025] Timer tick, asking Buildbucket for the build status
[13:56:42.182] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:42.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:62:0) after 1m0s
[13:57:42.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:62:0)
[13:57:42.208] Timer tick, asking Buildbucket for the build status
[13:57:42.306] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:42.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:63:0) after 1m0s
[13:58:42.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:63:0)
[13:58:42.380] Timer tick, asking Buildbucket for the build status
[13:58:42.911] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:42.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:64:0) after 1m0s
[13:59:43.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:64:0)
[13:59:43.029] Timer tick, asking Buildbucket for the build status
[13:59:43.605] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:43.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:65:0) after 1m0s
[14:00:43.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:65:0)
[14:00:43.664] Timer tick, asking Buildbucket for the build status
[14:00:43.721] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:43.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:66:0) after 1m0s
[14:01:43.728] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:66:0)
[14:01:43.728] Timer tick, asking Buildbucket for the build status
[14:01:43.898] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:43.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:67:0) after 1m0s
[14:02:43.920] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:67:0)
[14:02:43.920] Timer tick, asking Buildbucket for the build status
[14:02:44.203] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:44.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:68:0) after 1m0s
[14:03:44.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:68:0)
[14:03:44.231] Timer tick, asking Buildbucket for the build status
[14:03:44.331] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:44.331] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:69:0) after 1m0s
[14:04:44.382] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:69:0)
[14:04:44.382] Timer tick, asking Buildbucket for the build status
[14:04:44.458] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:44.458] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:70:0) after 1m0s
[14:05:44.648] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:70:0)
[14:05:44.648] Timer tick, asking Buildbucket for the build status
[14:05:45.322] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:45.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:71:0) after 1m0s
[14:06:45.415] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:71:0)
[14:06:45.415] Timer tick, asking Buildbucket for the build status
[14:06:45.489] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:45.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:72:0) after 1m0s
[14:07:45.603] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:72:0)
[14:07:45.603] Timer tick, asking Buildbucket for the build status
[14:07:45.649] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:45.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:73:0) after 1m0s
[14:08:45.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:73:0)
[14:08:45.674] Timer tick, asking Buildbucket for the build status
[14:08:45.758] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:45.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:74:0) after 1m0s
[14:09:45.867] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:74:0)
[14:09:45.867] Timer tick, asking Buildbucket for the build status
[14:09:45.925] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:45.925] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:75:0) after 1m0s
[14:10:45.983] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:75:0)
[14:10:45.983] Timer tick, asking Buildbucket for the build status
[14:10:46.047] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:46.047] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:76:0) after 1m0s
[14:11:46.093] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:76:0)
[14:11:46.093] Timer tick, asking Buildbucket for the build status
[14:11:46.324] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:46.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:77:0) after 1m0s
[14:12:46.358] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:77:0)
[14:12:46.358] Timer tick, asking Buildbucket for the build status
[14:12:46.512] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:46.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:78:0) after 1m0s
[14:13:46.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:78:0)
[14:13:46.483] Timer tick, asking Buildbucket for the build status
[14:13:46.936] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:46.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:79:0) after 1m0s
[14:14:47.013] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:79:0)
[14:14:47.014] Timer tick, asking Buildbucket for the build status
[14:14:47.329] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:47.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:80:0) after 1m0s
[14:15:47.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:80:0)
[14:15:47.459] Timer tick, asking Buildbucket for the build status
[14:15:47.625] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:47.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:81:0) after 1m0s
[14:16:47.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:81:0)
[14:16:47.740] Timer tick, asking Buildbucket for the build status
[14:16:48.998] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:48.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:82:0) after 1m0s
[14:17:49.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:82:0)
[14:17:49.103] Timer tick, asking Buildbucket for the build status
[14:17:49.201] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:49.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:83:0) after 1m0s
[14:18:49.288] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:83:0)
[14:18:49.288] Timer tick, asking Buildbucket for the build status
[14:18:49.351] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:49.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:84:0) after 1m0s
[14:19:49.476] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:84:0)
[14:19:49.476] Timer tick, asking Buildbucket for the build status
[14:19:49.657] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:49.657] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:85:0) after 1m0s
[14:20:49.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:85:0)
[14:20:49.677] Timer tick, asking Buildbucket for the build status
[14:20:49.834] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:49.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:86:0) after 1m0s
[14:21:49.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:86:0)
[14:21:49.872] Timer tick, asking Buildbucket for the build status
[14:21:49.993] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:49.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:87:0) after 1m0s
[14:22:50.133] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:87:0)
[14:22:50.133] Timer tick, asking Buildbucket for the build status
[14:22:50.217] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:50.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:88:0) after 1m0s
[14:23:50.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:88:0)
[14:23:50.289] Timer tick, asking Buildbucket for the build status
[14:23:50.456] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:50.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:89:0) after 1m0s
[14:24:50.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:89:0)
[14:24:50.498] Timer tick, asking Buildbucket for the build status
[14:24:50.578] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:50.578] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:90:0) after 1m0s
[14:25:50.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:90:0)
[14:25:50.655] Timer tick, asking Buildbucket for the build status
[14:25:50.736] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:50.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:91:0) after 1m0s
[14:26:50.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:91:0)
[14:26:50.809] Timer tick, asking Buildbucket for the build status
[14:26:50.915] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:50.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:92:0) after 1m0s
[14:27:50.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:92:0)
[14:27:50.944] Timer tick, asking Buildbucket for the build status
[14:27:51.158] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:51.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:93:0) after 1m0s
[14:28:51.190] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:93:0)
[14:28:51.190] Timer tick, asking Buildbucket for the build status
[14:28:51.257] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:51.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:94:0) after 1m0s
[14:29:51.250] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:94:0)
[14:29:51.250] Timer tick, asking Buildbucket for the build status
[14:29:51.306] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:51.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:95:0) after 1m0s
[14:30:51.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:95:0)
[14:30:51.460] Timer tick, asking Buildbucket for the build status
[14:30:51.519] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:51.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:96:0) after 1m0s
[14:31:51.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:96:0)
[14:31:51.548] Timer tick, asking Buildbucket for the build status
[14:31:51.601] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:51.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:97:0) after 1m0s
[14:32:51.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:97:0)
[14:32:51.621] Timer tick, asking Buildbucket for the build status
[14:32:51.717] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:51.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:98:0) after 1m0s
[14:33:51.751] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:98:0)
[14:33:51.751] Timer tick, asking Buildbucket for the build status
[14:33:51.804] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:51.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:99:0) after 1m0s
[14:34:51.906] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:99:0)
[14:34:51.906] Timer tick, asking Buildbucket for the build status
[14:34:52.046] Build 8860391677108002800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:52.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025821739095811584:100:0) after 1m0s
[14:35:48.129] Received PubSub notification, asking Buildbucket for the build status
[14:35:48.746] Build 8860391677108002800: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:35:48.746] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608474947368338",
"created_by": "project:chromium",
"created_ts": "1608469046450633",
"id": "8860391677108002800",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a23460e7f58da4db173cf41236206e6ff20cbf32\"}}",
"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\": \"a23460e7f58da4db173cf41236206e6ff20cbf32\", \"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-80-liq4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178840, \"got_angle_revision\": \"ed9213bca0643edb65b7d39a938210419398a1b3\", \"got_dawn_revision\": \"5d4fd88a7403aa255d49919d011af54c691b344a\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"a23460e7f58da4db173cf41236206e6ff20cbf32\", \"got_revision_cp\": \"refs/heads/master@{#838560}\", \"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\": \"a23460e7f58da4db173cf41236206e6ff20cbf32\", \"swarm_hashes_refs/heads/master(at){#838560}_without_patch\": {\"absl_hardening_tests\": \"8f375d384e5b8a2ebdecc24bca0624147a11a2f1\", \"accessibility_unittests\": \"05cdfc98837fe8719fd4b89090dae2a2b99f510b\", \"angle_unittests\": \"6291cbe995b57c402b427dcd62f8f6abc7b60ab2\", \"app_shell_unittests\": \"385834ad1d269a68b898254b175e63f9a8889c17\", \"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\": \"f511dc855c92b385e62909db9c809eef79773d65\", \"blink_web_tests\": \"b78b8318f1ba05683ada9ee474403f4b937856b5\", \"boringssl_crypto_tests\": \"339c2652771d7b3e164a30240cc807aad06fc5f2\", \"boringssl_ssl_tests\": \"4125b55d8cb2aefef23667153037cfe9fe874c0e\", \"browser_tests\": \"1f4da2ab152184219af0597071a478286107f726\", \"capture_unittests\": \"b6086e07ea995eed4030700d065abd4a2eaa0fa2\", \"cast_unittests\": \"cbb38d0211ab9276c59f0c5288c161615136333b\", \"cc_unittests\": \"ad6418234c6b1b5c1b18bdcba8a2eaf5182617d0\", \"chrome_app_unittests\": \"b2eae7a0957784a062f285b80e39ae992c33c1c4\", \"chromedriver_unittests\": \"673fec4ff87d09e86e1d4fcd6b69172f21aaf3a1\", \"components_browsertests\": \"20f68b5197794f2be92bde903d54e6b7ed45e5f7\", \"components_unittests\": \"181d37d9579928368c399a7580abd753408c2e19\", \"compositor_unittests\": \"3e153d166a333d9fe3d4fca33ee3716aa7a97217\", \"content_browsertests\": \"b4ce27bc4e8119d3dafa0c1d97be8d18e6fca243\", \"content_shell_crash_test\": \"8bc7a7f8ed50b7c53a49b880aa067ef1f38bde8f\", \"content_unittests\": \"3ecbbb92d098b8ca83adaa354764fd10669c55ca\", \"crashpad_tests\": \"49f3237b435657bd0a41708c953bbb6e2282e049\", \"cronet_tests\": \"7ed8027278d9a58de868f6e799f05442cf33fe96\", \"cronet_unittests\": \"d6a67615f321d41768ab8feddef8bfb5b104f1c3\", \"crypto_unittests\": \"b4ea65d67dbc4046191211f280ea3161f64e3024\", \"dbus_unittests\": \"97b1705f3871e03b4dd6c1be2b4fd003b75ee19e\", \"device_unittests\": \"5ff8a66aaea46b5a9136d29778ccc022bc322b00\", \"display_unittests\": \"30ea1167650ed5e6f7c5beecb9d9e0a1c15c0651\", \"events_unittests\": \"9d7d50ab12e9662ceaece244bf42bab9f401d7d7\", \"extension_docserver_python_unittests\": \"71bcd6b7573d94ae1247016c00563f0ec7b193dc\", \"extensions_browsertests\": \"1579b92af758340d212a369002fee0935a8ee5ed\", \"extensions_unittests\": \"6a7cffa6128f7cb82219afb1641b69bd64c2604b\", \"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\": \"6fda540ac105b8ebdb06cb19aeccfb7ed24e14b4\", \"headless_unittests\": \"6e44e5f07610046c92bcd93568abe8711b7d45ae\", \"interactive_ui_tests\": \"75ffef2cb3801d263e383e5cf6faf87e23389ae3\", \"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\": \"3c14088619b378d1504f0d70ff0973071c8b3de2\", \"native_theme_unittests\": \"4370d4c261fe25c03d4e4d30d76f3a4f33e0716e\", \"net_unittests\": \"ed63b978e2b48113613bbefe2bcd473d2b071a8e\", \"openscreen_unittests\": \"e25c6d874f45bf22d7822384b6716de1bc5ad537\", \"pdf_unittests\": \"6a0c08c710c05eb4dc2f0492753371585f5b1e19\", \"perfetto_unittests\": \"2b4794f2711a3c606bb1b5db4b17b4c5bc51e90d\", \"ppapi_unittests\": \"34fdb52a7fb70fc2a97b230b9279ae2e849aae58\", \"printing_unittests\": \"2f2252e03d70b8f687fb79df98939ed8de63dbf5\", \"remoting_unittests\": \"57145ef16fd2ad7b1c713b54e7caad82b676ca12\", \"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\": \"44dd6c37a3c121e7da8e36824500b59852e57c34\", \"telemetry_gpu_unittests\": \"ca794bdf5d544b215c5f22773623b14e24e956c3\", \"telemetry_perf_unittests\": \"8fefcfba9c9186591f817e49bf30c8e42611a940\", \"telemetry_unittests\": \"a632ce657b0c0917e1d34a765193cf957782ece6\", \"traffic_annotation_auditor_unittests\": \"5bc4e70c9e0e0b966adfbe4b674eb7999682a513\", \"ui_base_unittests\": \"e54cd8fac54613ffa5412088feb0bd069d35b867\", \"ui_touch_selection_unittests\": \"c0579655b924c159a29bc7db769723a2188c9685\", \"unit_tests\": \"a8da1fcf8d816daff07529b953d908a61c5aaf4c\", \"url_unittests\": \"eb4a65202e14902b6a6c737a6a15ba5786375147\", \"views_perftests\": \"b21e0b8443265442567bd53cb75542bec4558c40\", \"views_unittests\": \"215dbb99de85144c0390814606646574df99414f\", \"viz_unittests\": \"d088b29eb268c4a106a69ef5fd4832e6e6fb7f3f\", \"vr_common_unittests\": \"de2f0c73a89587fe71c9926aea227587c9b4dbeb\", \"vr_pixeltests\": \"0b4f7a1a68153f1d45b4e0edc257e9776c85d897\", \"webdriver_wpt_tests\": \"ea1cd33eb5dec50cd758e58ead9dce1fa9401b63\", \"weblayer_browsertests\": \"d47b92ef81c88d1798c98c23d11c4e5092e4a9cd\", \"weblayer_unittests\": \"61cdfc91422d96de077b654be5867bff27324c98\", \"wm_unittests\": \"ea5761e0dc3e4e5c07856056e92a04abe6068ee2\", \"wtf_unittests\": \"028058b3343ce2689e518f89f06238c0146b8b5a\", \"x11_unittests\": \"72642615448c8e7f4cdba628dae26ace4d89c41e\", \"xr_browser_tests\": \"e12d122a1ea040f8844b2af13bdb78a4b8ba1c40\", \"zlib_unittests\": \"d7b4949fd0c0340e972b0ab41b48f91449fbaa72\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3ee79eab7726d87d4f9bf92f4b58b9506b0a7a0d17f466f0c3d67bd50a4697d1_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_a1c3d05f1886c3c1a4b693e8245da857a9c63a0cda58ad280c9a386162f50760_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_de45c485d8a81e16b8ff53eb76d94467eed5e11e118465311a13e72e2b141cb1_v2\", \"builder_fe96da9c6a19fa2fc3ad0c2b7020b7cb68e4a92161f4cd6cb7dc1d1e2d5af5dc_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-80-liq4\"], \"image\": [\"chrome-xenial-20120600-c5cfbe11ce8\"], \"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": "1608470447648513",
"status": "COMPLETED",
"status_changed_ts": "1608474947664299",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178840",
"builder:Linux Builder (dbg)",
"buildset:commit/git/a23460e7f58da4db173cf41236206e6ff20cbf32",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a23460e7f58da4db173cf41236206e6ff20cbf32",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025821739095811584",
"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/8860391677108002800/+/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:50990bb53a2bdc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1608474947685832",
"url": "https://ci.chromium.org/b/8860391677108002800",
"utcnow_ts": "1608474948716039"
}
}
[14:35:48.746] Invocation finished in 1h38m23.57513875s with status SUCCEEDED