[08:23:06.070] New invocation is queued and will start shortly
[08:23:07.288] Starting the invocation (attempt 1)
[08:23:07.322] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:23:07.322] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:23:07.322] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024027058402378144",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e66ebd961561b82d30a3f48f1706000aa7b8aaa9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9024027058402378144",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/e66ebd961561b82d30a3f48f1706000aa7b8aaa9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e66ebd961561b82d30a3f48f1706000aa7b8aaa9",
"gitiles_ref:refs/heads/master"
]
}
[08:23:07.949] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610180587442158",
"id": "8858596996300218960",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e66ebd961561b82d30a3f48f1706000aa7b8aaa9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610180587826520",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179486",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e66ebd961561b82d30a3f48f1706000aa7b8aaa9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e66ebd961561b82d30a3f48f1706000aa7b8aaa9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024027058402378144",
"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/8858596996300218960/+/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": "1610180587826646",
"url": "https://ci.chromium.org/b/8858596996300218960",
"utcnow_ts": "1610180587941105"
}
}
[08:23:07.949] Task URL: https://ci.chromium.org/b/8858596996300218960
[08:23:07.949] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:2:0) after 1m0s
[08:24:08.058] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:2:0)
[08:24:08.058] Timer tick, asking Buildbucket for the build status
[08:24:08.158] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:24:08.158] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:3:0) after 1m0s
[08:25:08.263] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:3:0)
[08:25:08.263] Timer tick, asking Buildbucket for the build status
[08:25:08.370] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:25:08.370] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:4:0) after 1m0s
[08:26:08.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:4:0)
[08:26:08.514] Timer tick, asking Buildbucket for the build status
[08:26:08.583] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:26:08.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:5:0) after 1m0s
[08:27:08.764] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:5:0)
[08:27:08.764] Timer tick, asking Buildbucket for the build status
[08:27:08.835] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:27:08.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:6:0) after 1m0s
[08:28:09.118] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:6:0)
[08:28:09.118] Timer tick, asking Buildbucket for the build status
[08:28:09.498] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:28:09.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:7:0) after 1m0s
[08:29:09.577] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:7:0)
[08:29:09.577] Timer tick, asking Buildbucket for the build status
[08:29:09.642] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:29:09.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:8:0) after 1m0s
[08:30:09.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:8:0)
[08:30:09.675] Timer tick, asking Buildbucket for the build status
[08:30:09.802] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:30:09.802] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:9:0) after 1m0s
[08:31:09.897] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:9:0)
[08:31:09.897] Timer tick, asking Buildbucket for the build status
[08:31:09.971] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:31:09.971] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:10:0) after 1m0s
[08:32:09.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:10:0)
[08:32:09.944] Timer tick, asking Buildbucket for the build status
[08:32:10.022] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:32:10.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:11:0) after 1m0s
[08:33:10.083] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:11:0)
[08:33:10.083] Timer tick, asking Buildbucket for the build status
[08:33:10.179] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:33:10.179] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:12:0) after 1m0s
[08:34:10.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:12:0)
[08:34:10.281] Timer tick, asking Buildbucket for the build status
[08:34:10.470] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:34:10.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:13:0) after 1m0s
[08:35:10.504] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:13:0)
[08:35:10.504] Timer tick, asking Buildbucket for the build status
[08:35:10.705] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:35:10.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:14:0) after 1m0s
[08:36:10.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:14:0)
[08:36:10.778] Timer tick, asking Buildbucket for the build status
[08:36:10.930] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:36:10.930] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:15:0) after 1m0s
[08:37:11.104] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:15:0)
[08:37:11.104] Timer tick, asking Buildbucket for the build status
[08:37:11.431] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:37:11.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:16:0) after 1m0s
[08:38:11.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:16:0)
[08:38:11.533] Timer tick, asking Buildbucket for the build status
[08:38:11.661] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:38:11.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:17:0) after 1m0s
[08:39:11.737] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:17:0)
[08:39:11.737] Timer tick, asking Buildbucket for the build status
[08:39:11.798] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:39:11.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:18:0) after 1m0s
[08:40:11.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:18:0)
[08:40:11.856] Timer tick, asking Buildbucket for the build status
[08:40:12.371] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:40:12.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:19:0) after 1m0s
[08:41:12.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:19:0)
[08:41:12.355] Timer tick, asking Buildbucket for the build status
[08:41:12.479] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:41:12.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:20:0) after 1m0s
[08:42:12.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:20:0)
[08:42:12.520] Timer tick, asking Buildbucket for the build status
[08:42:12.645] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:42:12.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:21:0) after 1m0s
[08:43:12.647] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:21:0)
[08:43:12.647] Timer tick, asking Buildbucket for the build status
[08:43:12.734] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:43:12.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:22:0) after 1m0s
[08:44:12.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:22:0)
[08:44:12.835] Timer tick, asking Buildbucket for the build status
[08:44:12.965] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:44:12.965] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:23:0) after 1m0s
[08:45:12.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:23:0)
[08:45:12.981] Timer tick, asking Buildbucket for the build status
[08:45:13.260] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:45:13.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:24:0) after 1m0s
[08:46:13.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:24:0)
[08:46:13.281] Timer tick, asking Buildbucket for the build status
[08:46:13.538] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:46:13.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:25:0) after 1m0s
[08:47:13.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:25:0)
[08:47:13.673] Timer tick, asking Buildbucket for the build status
[08:47:13.771] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:47:13.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:26:0) after 1m0s
[08:48:13.805] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:26:0)
[08:48:13.805] Timer tick, asking Buildbucket for the build status
[08:48:14.031] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:48:14.031] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:27:0) after 1m0s
[08:49:14.084] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:27:0)
[08:49:14.084] Timer tick, asking Buildbucket for the build status
[08:49:14.333] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:49:14.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:28:0) after 1m0s
[08:50:14.413] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:28:0)
[08:50:14.413] Timer tick, asking Buildbucket for the build status
[08:50:14.519] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:50:14.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:29:0) after 1m0s
[08:51:14.592] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:29:0)
[08:51:14.592] Timer tick, asking Buildbucket for the build status
[08:51:14.668] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:51:14.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:30:0) after 1m0s
[08:52:14.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:30:0)
[08:52:14.799] Timer tick, asking Buildbucket for the build status
[08:52:14.872] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:52:14.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:31:0) after 1m0s
[08:53:14.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:31:0)
[08:53:14.952] Timer tick, asking Buildbucket for the build status
[08:53:15.107] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:53:15.108] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:32:0) after 1m0s
[08:54:15.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:32:0)
[08:54:15.173] Timer tick, asking Buildbucket for the build status
[08:54:15.309] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:54:15.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:33:0) after 1m0s
[08:55:15.456] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:33:0)
[08:55:15.456] Timer tick, asking Buildbucket for the build status
[08:55:15.525] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:55:15.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:34:0) after 1m0s
[08:56:15.566] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:34:0)
[08:56:15.566] Timer tick, asking Buildbucket for the build status
[08:56:15.799] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:56:15.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:35:0) after 1m0s
[08:57:15.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:35:0)
[08:57:15.959] Timer tick, asking Buildbucket for the build status
[08:57:16.086] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:57:16.087] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:36:0) after 1m0s
[08:58:16.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:36:0)
[08:58:16.187] Timer tick, asking Buildbucket for the build status
[08:58:16.298] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:58:16.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:37:0) after 1m0s
[08:59:16.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:37:0)
[08:59:16.401] Timer tick, asking Buildbucket for the build status
[08:59:16.491] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:59:16.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:38:0) after 1m0s
[09:00:16.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:38:0)
[09:00:16.619] Timer tick, asking Buildbucket for the build status
[09:00:16.764] Build 8858596996300218960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:00:16.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:39:0) after 1m0s
[09:00:26.549] Received PubSub notification, asking Buildbucket for the build status
[09:00:26.708] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:16.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:39:0)
[09:01:16.803] Timer tick, asking Buildbucket for the build status
[09:01:16.895] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:16.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:41:0) after 1m0s
[09:02:17.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:41:0)
[09:02:17.067] Timer tick, asking Buildbucket for the build status
[09:02:17.138] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:17.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:42:0) after 1m0s
[09:03:17.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:42:0)
[09:03:17.477] Timer tick, asking Buildbucket for the build status
[09:03:17.867] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:17.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:43:0) after 1m0s
[09:04:17.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:43:0)
[09:04:17.959] Timer tick, asking Buildbucket for the build status
[09:04:18.053] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:18.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:44:0) after 1m0s
[09:05:18.253] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:44:0)
[09:05:18.253] Timer tick, asking Buildbucket for the build status
[09:05:18.763] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:18.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:45:0) after 1m0s
[09:06:18.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:45:0)
[09:06:18.839] Timer tick, asking Buildbucket for the build status
[09:06:19.022] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:19.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:46:0) after 1m0s
[09:07:19.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:46:0)
[09:07:19.116] Timer tick, asking Buildbucket for the build status
[09:07:19.178] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:19.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:47:0) after 1m0s
[09:08:19.404] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:47:0)
[09:08:19.404] Timer tick, asking Buildbucket for the build status
[09:08:19.817] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:19.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:48:0) after 1m0s
[09:09:20.005] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:48:0)
[09:09:20.005] Timer tick, asking Buildbucket for the build status
[09:09:20.093] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:20.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:49:0) after 1m0s
[09:10:20.163] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:49:0)
[09:10:20.163] Timer tick, asking Buildbucket for the build status
[09:10:20.275] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:20.275] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:50:0) after 1m0s
[09:11:20.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:50:0)
[09:11:20.307] Timer tick, asking Buildbucket for the build status
[09:11:20.480] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:20.480] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:51:0) after 1m0s
[09:12:20.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:51:0)
[09:12:20.619] Timer tick, asking Buildbucket for the build status
[09:12:20.736] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:20.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:52:0) after 1m0s
[09:13:20.761] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:52:0)
[09:13:20.761] Timer tick, asking Buildbucket for the build status
[09:13:21.195] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:21.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:53:0) after 1m0s
[09:14:21.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:53:0)
[09:14:21.238] Timer tick, asking Buildbucket for the build status
[09:14:21.292] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:21.292] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:54:0) after 1m0s
[09:15:21.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:54:0)
[09:15:21.401] Timer tick, asking Buildbucket for the build status
[09:15:21.598] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:21.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:55:0) after 1m0s
[09:16:21.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:55:0)
[09:16:21.724] Timer tick, asking Buildbucket for the build status
[09:16:22.412] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:22.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:56:0) after 1m0s
[09:17:22.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:56:0)
[09:17:22.536] Timer tick, asking Buildbucket for the build status
[09:17:22.596] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:22.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:57:0) after 1m0s
[09:18:22.687] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:57:0)
[09:18:22.687] Timer tick, asking Buildbucket for the build status
[09:18:22.978] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:22.978] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:58:0) after 1m0s
[09:19:23.135] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:58:0)
[09:19:23.135] Timer tick, asking Buildbucket for the build status
[09:19:23.218] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:23.218] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:59:0) after 1m0s
[09:20:23.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:59:0)
[09:20:23.215] Timer tick, asking Buildbucket for the build status
[09:20:23.269] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:23.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:60:0) after 1m0s
[09:21:23.301] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:60:0)
[09:21:23.301] Timer tick, asking Buildbucket for the build status
[09:21:23.388] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:23.388] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:61:0) after 1m0s
[09:22:23.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:61:0)
[09:22:23.393] Timer tick, asking Buildbucket for the build status
[09:22:23.461] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:23.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:62:0) after 1m0s
[09:23:23.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:62:0)
[09:23:23.506] Timer tick, asking Buildbucket for the build status
[09:23:23.616] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:23.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:63:0) after 1m0s
[09:24:23.639] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:63:0)
[09:24:23.639] Timer tick, asking Buildbucket for the build status
[09:24:23.714] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:23.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:64:0) after 1m0s
[09:25:23.771] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:64:0)
[09:25:23.771] Timer tick, asking Buildbucket for the build status
[09:25:23.831] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:23.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:65:0) after 1m0s
[09:26:23.895] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:65:0)
[09:26:23.896] Timer tick, asking Buildbucket for the build status
[09:26:23.950] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:23.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:66:0) after 1m0s
[09:27:24.007] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:66:0)
[09:27:24.007] Timer tick, asking Buildbucket for the build status
[09:27:24.418] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:24.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:67:0) after 1m0s
[09:28:24.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:67:0)
[09:28:24.528] Timer tick, asking Buildbucket for the build status
[09:28:24.633] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:24.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:68:0) after 1m0s
[09:29:24.656] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:68:0)
[09:29:24.656] Timer tick, asking Buildbucket for the build status
[09:29:24.709] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:24.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:69:0) after 1m0s
[09:30:24.734] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:69:0)
[09:30:24.734] Timer tick, asking Buildbucket for the build status
[09:30:24.785] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:24.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:70:0) after 1m0s
[09:31:24.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:70:0)
[09:31:24.875] Timer tick, asking Buildbucket for the build status
[09:31:24.950] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:24.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:71:0) after 1m0s
[09:32:25.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:71:0)
[09:32:25.101] Timer tick, asking Buildbucket for the build status
[09:32:25.154] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:25.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:72:0) after 1m0s
[09:33:25.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:72:0)
[09:33:25.193] Timer tick, asking Buildbucket for the build status
[09:33:25.301] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:25.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:73:0) after 1m0s
[09:34:25.376] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:73:0)
[09:34:25.376] Timer tick, asking Buildbucket for the build status
[09:34:25.518] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:25.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:74:0) after 1m0s
[09:35:25.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:74:0)
[09:35:25.538] Timer tick, asking Buildbucket for the build status
[09:35:25.596] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:25.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:75:0) after 1m0s
[09:36:25.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:75:0)
[09:36:25.617] Timer tick, asking Buildbucket for the build status
[09:36:25.678] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:25.678] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:76:0) after 1m0s
[09:37:25.678] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:76:0)
[09:37:25.678] Timer tick, asking Buildbucket for the build status
[09:37:25.933] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:25.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:77:0) after 1m0s
[09:38:25.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:77:0)
[09:38:25.955] Timer tick, asking Buildbucket for the build status
[09:38:26.056] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:26.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:78:0) after 1m0s
[09:39:26.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:78:0)
[09:39:26.103] Timer tick, asking Buildbucket for the build status
[09:39:26.196] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:26.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:79:0) after 1m0s
[09:40:26.258] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:79:0)
[09:40:26.258] Timer tick, asking Buildbucket for the build status
[09:40:26.324] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:26.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:80:0) after 1m0s
[09:41:26.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:80:0)
[09:41:26.316] Timer tick, asking Buildbucket for the build status
[09:41:26.375] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:26.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:81:0) after 1m0s
[09:42:26.494] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:81:0)
[09:42:26.494] Timer tick, asking Buildbucket for the build status
[09:42:26.545] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:26.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:82:0) after 1m0s
[09:43:26.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:82:0)
[09:43:26.609] Timer tick, asking Buildbucket for the build status
[09:43:27.089] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:27.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:83:0) after 1m0s
[09:44:27.175] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:83:0)
[09:44:27.175] Timer tick, asking Buildbucket for the build status
[09:44:27.254] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:27.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:84:0) after 1m0s
[09:45:27.305] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:84:0)
[09:45:27.305] Timer tick, asking Buildbucket for the build status
[09:45:27.362] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:27.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:85:0) after 1m0s
[09:46:27.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:85:0)
[09:46:27.418] Timer tick, asking Buildbucket for the build status
[09:46:27.487] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:27.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:86:0) after 1m0s
[09:47:27.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:86:0)
[09:47:27.507] Timer tick, asking Buildbucket for the build status
[09:47:27.605] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:27.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:87:0) after 1m0s
[09:48:27.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:87:0)
[09:48:27.624] Timer tick, asking Buildbucket for the build status
[09:48:27.776] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:27.776] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:88:0) after 1m0s
[09:49:27.832] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:88:0)
[09:49:27.832] Timer tick, asking Buildbucket for the build status
[09:49:27.899] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:27.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:89:0) after 1m0s
[09:50:27.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:89:0)
[09:50:27.918] Timer tick, asking Buildbucket for the build status
[09:50:28.095] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:28.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:90:0) after 1m0s
[09:51:28.182] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:90:0)
[09:51:28.182] Timer tick, asking Buildbucket for the build status
[09:51:28.245] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:28.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:91:0) after 1m0s
[09:52:28.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:91:0)
[09:52:28.294] Timer tick, asking Buildbucket for the build status
[09:52:28.346] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:28.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:92:0) after 1m0s
[09:53:28.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:92:0)
[09:53:28.395] Timer tick, asking Buildbucket for the build status
[09:53:28.772] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:28.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:93:0) after 1m0s
[09:54:28.849] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:93:0)
[09:54:28.849] Timer tick, asking Buildbucket for the build status
[09:54:28.905] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:28.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:94:0) after 1m0s
[09:55:28.945] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:94:0)
[09:55:28.945] Timer tick, asking Buildbucket for the build status
[09:55:29.014] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:29.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:95:0) after 1m0s
[09:56:29.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:95:0)
[09:56:29.078] Timer tick, asking Buildbucket for the build status
[09:56:29.141] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:29.141] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:96:0) after 1m0s
[09:57:29.218] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:96:0)
[09:57:29.218] Timer tick, asking Buildbucket for the build status
[09:57:29.313] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:29.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:97:0) after 1m0s
[09:58:29.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:97:0)
[09:58:29.333] Timer tick, asking Buildbucket for the build status
[09:58:29.417] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:29.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:98:0) after 1m0s
[09:59:29.457] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:98:0)
[09:59:29.457] Timer tick, asking Buildbucket for the build status
[09:59:29.703] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:29.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:99:0) after 1m0s
[10:00:29.725] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:99:0)
[10:00:29.725] Timer tick, asking Buildbucket for the build status
[10:00:29.929] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:29.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:100:0) after 1m0s
[10:01:29.934] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:100:0)
[10:01:29.934] Timer tick, asking Buildbucket for the build status
[10:01:29.995] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:29.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:101:0) after 1m0s
[10:02:30.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:101:0)
[10:02:30.052] Timer tick, asking Buildbucket for the build status
[10:02:30.106] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:30.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:102:0) after 1m0s
[10:03:30.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:102:0)
[10:03:30.085] Timer tick, asking Buildbucket for the build status
[10:03:30.185] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:30.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:103:0) after 1m0s
[10:04:30.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:103:0)
[10:04:30.205] Timer tick, asking Buildbucket for the build status
[10:04:30.265] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:30.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:104:0) after 1m0s
[10:05:30.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:104:0)
[10:05:30.324] Timer tick, asking Buildbucket for the build status
[10:05:30.575] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:30.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:105:0) after 1m0s
[10:06:30.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:105:0)
[10:06:30.650] Timer tick, asking Buildbucket for the build status
[10:06:31.062] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:31.062] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:106:0) after 1m0s
[10:07:31.172] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:106:0)
[10:07:31.172] Timer tick, asking Buildbucket for the build status
[10:07:31.267] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:31.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:107:0) after 1m0s
[10:08:31.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:107:0)
[10:08:31.333] Timer tick, asking Buildbucket for the build status
[10:08:31.453] Build 8858596996300218960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:31.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024027058402378144:108:0) after 1m0s
[10:09:06.673] Received PubSub notification, asking Buildbucket for the build status
[10:09:06.809] Build 8858596996300218960: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:09:06.809] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610186946113110",
"created_by": "project:chromium",
"created_ts": "1610180587442158",
"id": "8858596996300218960",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e66ebd961561b82d30a3f48f1706000aa7b8aaa9\"}}",
"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\": \"e66ebd961561b82d30a3f48f1706000aa7b8aaa9\", \"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-79-fbjj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 179486, \"got_angle_revision\": \"6e909d9407534e3b7e4eb42e49941256a14066b5\", \"got_dawn_revision\": \"c9a22bcb93db27e200a184c1f7b9bf0f288815c7\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"e66ebd961561b82d30a3f48f1706000aa7b8aaa9\", \"got_revision_cp\": \"refs/heads/master@{#841801}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"588d32cb3f172d1a6092c2b3c7e5a5c5d8b3b06e\", \"got_v8_revision\": \"6bb19707a491fda7a4dc04dbbeb188d48f6d641d\", \"got_v8_revision_cp\": \"refs/heads/8.9.225@{#1}\", \"got_webrtc_revision\": \"783278a3109df8d2e362861e52fd0deea851633c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32927}\", \"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\": \"e66ebd961561b82d30a3f48f1706000aa7b8aaa9\", \"swarm_hashes_refs/heads/master(at){#841801}_without_patch\": {\"absl_hardening_tests\": \"438624492ec3a89e73588d398bc2e7c2fac5ba7d\", \"accessibility_unittests\": \"840fba3360342a37eec109f9968531fc3d4d166a\", \"angle_unittests\": \"ee53132b2fe6f561f59923d190331e71b4954aab\", \"app_shell_unittests\": \"0fab8435afe3a169707a84732b0bed69f4144583\", \"aura_unittests\": \"e6efd35ad3fceb7b50c031be870460b704f8d816\", \"base_unittests\": \"57b57ed2d8cf4935c1667687537acfe966decc75\", \"base_util_unittests\": \"a1070327964cdeae3ce6fe822f2538136fd15183\", \"blink_common_unittests\": \"6e8ae647390c294b16da3c4855345745007425b0\", \"blink_fuzzer_unittests\": \"5d0941aa375e474bf1e67842841c1e03a1028e27\", \"blink_heap_unittests\": \"db5fa215a74d8936d4703b4e70e215df5c6fadb6\", \"blink_platform_unittests\": \"d8a056a2a8cf8b4f7551808b15479dc90c44d75c\", \"blink_python_tests\": \"aad54347d2487f4d8cdd16952777901acd8801fd\", \"blink_unittests\": \"957220a32237a91996c16cc49a621cef2a6ebd0e\", \"blink_web_tests\": \"a9cb5ab4f3073ffde4c6b5d8f48e05194637c685\", \"boringssl_crypto_tests\": \"48cca37834f8d95fe5893063602f7993467516e5\", \"boringssl_ssl_tests\": \"ba01118e11eca97bed19e84d978c5f881116eb81\", \"browser_tests\": \"abb36c7e5243674a96723f3863123d3079910a13\", \"capture_unittests\": \"4cfdcac4906a88c5feddd1afb619eb43ec8784db\", \"cast_unittests\": \"795e0d9865c2f33aa6d271e70ac814bf41df03de\", \"cc_unittests\": \"940c494c7ca520821d48ecbcf946f1f39ddf80b6\", \"chrome_app_unittests\": \"1018c053eb995d7bc7924da6b1e163bbcfd1735d\", \"chromedriver_unittests\": \"3c5ecc3f42485098e25e2fb42c728edf36e4196a\", \"components_browsertests\": \"0e0ca555ce0157d745b8274f7299e49e616625ac\", \"components_unittests\": \"91da2b58c7ce6ab19690b7f65cde96107e5732c4\", \"compositor_unittests\": \"824d1fc0b110730c1452bb33380324efb37592ab\", \"content_browsertests\": \"efd46849a9288df87e1ac73670ad811eaaccc551\", \"content_shell_crash_test\": \"23c3a8a4bddaaecb15b5d4e22a1c59ca8a2a29ed\", \"content_unittests\": \"41d664372467a07683eae9d421932d7d78177f76\", \"crashpad_tests\": \"7264240843092cefb37e55e029f4fc4d13452e8a\", \"cronet_tests\": \"5732b6d8a7df6b79aa14418e2d223d35581a9f3e\", \"cronet_unittests\": \"4245381285c01c1fd57015fbe3a29e1b58fc2d12\", \"crypto_unittests\": \"9f03813873cae4a2bd1a5d8bfff35fcded374f03\", \"dbus_unittests\": \"28f63f61f1ee73c7bdbb43de5aea2e92f014ecae\", \"device_unittests\": \"d89c2abd5d0bacc65b0de86f9faba7fb35369520\", \"display_unittests\": \"0c66f48db4ecd0d351aeadff491e891db900718d\", \"events_unittests\": \"92348ffdc2f104573ab52ed00b5fbc8e58f1b2f1\", \"extensions_browsertests\": \"c31462ebdb57faed2e0e728d0862e5a01250d1f3\", \"extensions_unittests\": \"437b396736f8bb3c30704ab7a4c63aca096110b2\", \"filesystem_service_unittests\": \"00571bc0b9dba4d2efbdaacbf75d1c4e9d6af547\", \"flatbuffers_unittests\": \"cc869a2fbd06ae1fab18c809541dec3b75d7db1a\", \"gcm_unit_tests\": \"cdad67064a247800629686f709d30dd693645a1f\", \"gfx_unittests\": \"1c0424b64ed2c3f65fc114aa2f303014e00a6b37\", \"gin_unittests\": \"97b36e326481eb670f2e5af91b8863653f871886\", \"google_apis_unittests\": \"26103cd714f62caa9d738fb383bf4371ebe80cf4\", \"gpu_unittests\": \"24e892b325622469b51a82032cc4ebb121231514\", \"grit_python_unittests\": \"0718a5373aa0ae8758877d63c90aad8024074ace\", \"gwp_asan_unittests\": \"2758f69531e52fda921c4ef913703df82fcb002c\", \"headless_browsertests\": \"7a9abe2cd75d56553e71ef385f04184ba29ac6c1\", \"headless_unittests\": \"07de7fde126181cf3543ef9719e856dff8c2f18b\", \"interactive_ui_tests\": \"590d7ece13120bf57653ffb2dbf857b740fde236\", \"ipc_tests\": \"dcd0b2e6d154a3d1e7baed7391f72c58abb9e481\", \"jingle_unittests\": \"ae5e84005c5ccdf58033b7ad231dd9dffe351b06\", \"latency_unittests\": \"b0b10ba8197a3821c8cbfaf1d2081216806b9345\", \"libjingle_xmpp_unittests\": \"025a33b79d44c8e46972102917a177acbf089ff2\", \"liburlpattern_unittests\": \"157dbe3a034e9ae1540b77c9e8864a9eb21b85fe\", \"media_blink_unittests\": \"b7d644f6ee5c6cdf36f8c32444a59adfae92f758\", \"media_unittests\": \"387b36764fb6b31427209e68637c241dfa485222\", \"message_center_unittests\": \"42278d7a12edd5e3035cc93ca14366700f42b34f\", \"metrics_python_tests\": \"3754d2123641e69839e1df07b30ef8dd043f26b5\", \"midi_unittests\": \"1552e82fe88a44cfbff6715fc956e74e8a7ebb04\", \"mojo_core_unittests\": \"8fe9c0947452e9449ff5e0eb6e5376c07393e3f7\", \"mojo_unittests\": \"6da81fad499771049b49480abf07fe2d97b9483e\", \"nacl_helper_nonsfi_unittests\": \"8b51d73cf07a7b7ae8b96db06b7616a4ccd86937\", \"nacl_loader_unittests\": \"fa63d51ba08b35574cf3dcdf86ed11f5d3ff8b7d\", \"native_theme_unittests\": \"5fb2e0fdd0be08ebfd9d05acce8f91b9bfe89bb3\", \"net_unittests\": \"13693d9965a6f7a2fb16767a01b2b857ceb2dec0\", \"openscreen_unittests\": \"34f2260882479dc1cd781691f7dc81ae4ebe2aa6\", \"pdf_unittests\": \"1305a543490895b950b21aad0c67403e98221bf2\", \"perfetto_unittests\": \"2b21b075e61151dd05839dd6cd3c53603d543266\", \"ppapi_unittests\": \"c94a4039bf08641ce46b4f0cc53c519139a3eb93\", \"printing_unittests\": \"4840b20b532ec9cf55e74ddf401d9e44674bfc9e\", \"remoting_unittests\": \"7aaab51f36ccdea1548247be517b34eede1a1b64\", \"sandbox_linux_unittests\": \"8a3a118f8143662087b77ffc0d0602f0e14e3d4c\", \"service_manager_unittests\": \"f626df239ca13556b61ce496960501b495e726a5\", \"services_unittests\": \"858150256b28e1e6e1098efece51754151be5647\", \"shell_dialogs_unittests\": \"af8671363a645066b34f10d1f51b2ac185a5dd91\", \"skia_unittests\": \"4d7c133a544c31cf5af01e3664dca0f37f5f994e\", \"snapshot_unittests\": \"78220e314a82dbc5c63a122b11766b0a3eb09ee2\", \"sql_unittests\": \"847f6f0f0fbb84e02d7982138274915daab8cef1\", \"storage_unittests\": \"213776e15d7d44955d15afd4a35cce00b622aedc\", \"sync_integration_tests\": \"a485427f35521d5aff67854654af71565dbb7a0f\", \"telemetry_gpu_unittests\": \"9f937d2debd049a867fb8f7d53f28deed73a9509\", \"telemetry_perf_unittests\": \"03ea94f6b97b482cc9671cda6eb3d653ea394fd5\", \"telemetry_unittests\": \"4092b272bd911febe49d1828469f3002b414f797\", \"traffic_annotation_auditor_unittests\": \"b48ddfd493ca766084e05996de63cf291fe15f1d\", \"ui_base_unittests\": \"5c90d9aa458a05cc082d6ea07108b44d4af6c563\", \"ui_touch_selection_unittests\": \"b7e2b49e078949b1ac5ebb622bca07f4e651e77c\", \"unit_tests\": \"41b90139b972ea3b144f0cde51eb7ab2be39b0e7\", \"url_unittests\": \"9a7d4543e70da3a37b59d050a34eb66f9be745d0\", \"views_perftests\": \"9360100075b9f182ef9c63f267be30bbbe109de5\", \"views_unittests\": \"08b8686a71a6ef23321f4789467d8df84e242eea\", \"viz_unittests\": \"af51ec451035af44d76a8ca8d649031b3492ae9d\", \"vr_common_unittests\": \"50179d58630ebd9f54b342eb099e63b3de3e4dbd\", \"vr_pixeltests\": \"5def9c3bfc4d4bd0eef14d97ee000d4faa0a5985\", \"webdriver_wpt_tests\": \"0a2dec4bbbfdaf8c2a8e7fe83a8061a992e080d9\", \"weblayer_browsertests\": \"9c178e46396d3eb635cd5aad10bd710fb725739c\", \"weblayer_unittests\": \"a1e7e846e03ac1aa80f53b929d63e12f81e0e357\", \"wm_unittests\": \"38bfebb392209f75c5ec2ea2c339b0cabec46f73\", \"wtf_unittests\": \"4e8a27bb249e6f1f19d36f70c6fd3f2dde89b3b8\", \"x11_unittests\": \"3ff3117421a8409b59be33fce7c8d6d831f2a5ea\", \"xr_browser_tests\": \"288a01e89af0c1d79e33d82471c00f8527ddba35\", \"zlib_unittests\": \"917a2a4c757b3f6fcd3128d1c6b1a3f513b98afb\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_47c3ec4238d3b3d0448e41826f5b2c1435e77a4255b8c93aa27077a59a7a5a67_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_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-79-fbjj\"], \"image\": [\"chrome-xenial-20122700-a13233ce10d\"], \"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": "1610182825359778",
"status": "COMPLETED",
"status_changed_ts": "1610186946383312",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179486",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e66ebd961561b82d30a3f48f1706000aa7b8aaa9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e66ebd961561b82d30a3f48f1706000aa7b8aaa9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024027058402378144",
"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/8858596996300218960/+/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:50ff0f7b41936810",
"user_agent:luci-scheduler"
],
"updated_ts": "1610186946391151",
"url": "https://ci.chromium.org/b/8858596996300218960",
"utcnow_ts": "1610186946797017"
}
}
[10:09:06.809] Invocation finished in 1h46m0.755242815s with status SUCCEEDED