[22:19:26.101] New invocation is queued and will start shortly
[22:19:27.161] Starting the invocation (attempt 1)
[22:19:27.196] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:19:27.196] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:19:27.196] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023883843866160544",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e9fe59463e3d72c72f22306738c412a175164826\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9023883843866160544",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/e9fe59463e3d72c72f22306738c412a175164826",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e9fe59463e3d72c72f22306738c412a175164826",
"gitiles_ref:refs/heads/master"
]
}
[22:19:27.929] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610317167273788",
"id": "8858453781967578816",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e9fe59463e3d72c72f22306738c412a175164826\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610317167712785",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179507",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e9fe59463e3d72c72f22306738c412a175164826",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e9fe59463e3d72c72f22306738c412a175164826",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023883843866160544",
"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/8858453781967578816/+/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": "1610317167712889",
"url": "https://ci.chromium.org/b/8858453781967578816",
"utcnow_ts": "1610317167911018"
}
}
[22:19:27.929] Task URL: https://ci.chromium.org/b/8858453781967578816
[22:19:27.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:2:0) after 1m0s
[22:20:27.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:2:0)
[22:20:27.944] Timer tick, asking Buildbucket for the build status
[22:20:28.225] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:20:28.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:3:0) after 1m0s
[22:21:28.245] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:3:0)
[22:21:28.245] Timer tick, asking Buildbucket for the build status
[22:21:28.373] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:21:28.373] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:4:0) after 1m0s
[22:22:28.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:4:0)
[22:22:28.423] Timer tick, asking Buildbucket for the build status
[22:22:28.506] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:22:28.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:5:0) after 1m0s
[22:23:28.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:5:0)
[22:23:28.573] Timer tick, asking Buildbucket for the build status
[22:23:31.342] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:23:31.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:6:0) after 1m0s
[22:24:31.365] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:6:0)
[22:24:31.365] Timer tick, asking Buildbucket for the build status
[22:24:31.622] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:24:31.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:7:0) after 1m0s
[22:25:31.731] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:7:0)
[22:25:31.731] Timer tick, asking Buildbucket for the build status
[22:25:31.797] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:25:31.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:8:0) after 1m0s
[22:26:31.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:8:0)
[22:26:31.857] Timer tick, asking Buildbucket for the build status
[22:26:31.954] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:26:31.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:9:0) after 1m0s
[22:27:31.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:9:0)
[22:27:31.979] Timer tick, asking Buildbucket for the build status
[22:27:32.212] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:27:32.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:10:0) after 1m0s
[22:28:32.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:10:0)
[22:28:32.241] Timer tick, asking Buildbucket for the build status
[22:28:32.305] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:28:32.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:11:0) after 1m0s
[22:29:32.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:11:0)
[22:29:32.329] Timer tick, asking Buildbucket for the build status
[22:29:32.429] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:29:32.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:12:0) after 1m0s
[22:30:32.571] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:12:0)
[22:30:32.571] Timer tick, asking Buildbucket for the build status
[22:30:32.664] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:30:32.664] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:13:0) after 1m0s
[22:31:32.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:13:0)
[22:31:32.716] Timer tick, asking Buildbucket for the build status
[22:31:32.813] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:31:32.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:14:0) after 1m0s
[22:32:32.962] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:14:0)
[22:32:32.962] Timer tick, asking Buildbucket for the build status
[22:32:33.027] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:32:33.027] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:15:0) after 1m0s
[22:33:33.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:15:0)
[22:33:33.065] Timer tick, asking Buildbucket for the build status
[22:33:33.145] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:33:33.145] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:16:0) after 1m0s
[22:34:33.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:16:0)
[22:34:33.164] Timer tick, asking Buildbucket for the build status
[22:34:33.303] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:34:33.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:17:0) after 1m0s
[22:35:33.353] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:17:0)
[22:35:33.353] Timer tick, asking Buildbucket for the build status
[22:35:33.491] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:35:33.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:18:0) after 1m0s
[22:36:33.508] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:18:0)
[22:36:33.508] Timer tick, asking Buildbucket for the build status
[22:36:33.582] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:36:33.582] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:19:0) after 1m0s
[22:37:33.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:19:0)
[22:37:33.666] Timer tick, asking Buildbucket for the build status
[22:37:33.752] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:37:33.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:20:0) after 1m0s
[22:38:33.910] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:20:0)
[22:38:33.910] Timer tick, asking Buildbucket for the build status
[22:38:33.990] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:38:33.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:21:0) after 1m0s
[22:39:34.037] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:21:0)
[22:39:34.037] Timer tick, asking Buildbucket for the build status
[22:39:34.157] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:39:34.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:22:0) after 1m0s
[22:40:34.176] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:22:0)
[22:40:34.176] Timer tick, asking Buildbucket for the build status
[22:40:34.345] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:40:34.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:23:0) after 1m0s
[22:41:34.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:23:0)
[22:41:34.371] Timer tick, asking Buildbucket for the build status
[22:41:34.616] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:41:34.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:24:0) after 1m0s
[22:42:34.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:24:0)
[22:42:34.707] Timer tick, asking Buildbucket for the build status
[22:42:34.885] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:42:34.885] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:25:0) after 1m0s
[22:43:34.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:25:0)
[22:43:34.903] Timer tick, asking Buildbucket for the build status
[22:43:35.006] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:43:35.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:26:0) after 1m0s
[22:44:35.026] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:26:0)
[22:44:35.026] Timer tick, asking Buildbucket for the build status
[22:44:35.149] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:44:35.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:27:0) after 1m0s
[22:45:35.243] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:27:0)
[22:45:35.243] Timer tick, asking Buildbucket for the build status
[22:45:35.397] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:35.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:28:0) after 1m0s
[22:46:35.420] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:28:0)
[22:46:35.420] Timer tick, asking Buildbucket for the build status
[22:46:35.497] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:35.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:29:0) after 1m0s
[22:47:35.718] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:29:0)
[22:47:35.718] Timer tick, asking Buildbucket for the build status
[22:47:35.801] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:35.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:30:0) after 1m0s
[22:48:36.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:30:0)
[22:48:36.388] Timer tick, asking Buildbucket for the build status
[22:48:36.520] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:36.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:31:0) after 1m0s
[22:49:36.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:31:0)
[22:49:36.642] Timer tick, asking Buildbucket for the build status
[22:49:36.751] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:36.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:32:0) after 1m0s
[22:50:36.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:32:0)
[22:50:36.810] Timer tick, asking Buildbucket for the build status
[22:50:36.877] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:36.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:33:0) after 1m0s
[22:51:37.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:33:0)
[22:51:37.028] Timer tick, asking Buildbucket for the build status
[22:51:37.102] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:37.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:34:0) after 1m0s
[22:52:37.275] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:34:0)
[22:52:37.275] Timer tick, asking Buildbucket for the build status
[22:52:37.434] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:37.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:35:0) after 1m0s
[22:53:37.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:35:0)
[22:53:37.796] Timer tick, asking Buildbucket for the build status
[22:53:37.884] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:37.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:36:0) after 1m0s
[22:54:38.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:36:0)
[22:54:38.062] Timer tick, asking Buildbucket for the build status
[22:54:38.179] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:38.179] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:37:0) after 1m0s
[22:55:38.171] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:37:0)
[22:55:38.172] Timer tick, asking Buildbucket for the build status
[22:55:38.252] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:38.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:38:0) after 1m0s
[22:56:38.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:38:0)
[22:56:38.347] Timer tick, asking Buildbucket for the build status
[22:56:38.429] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:38.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:39:0) after 1m0s
[22:57:38.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:39:0)
[22:57:38.477] Timer tick, asking Buildbucket for the build status
[22:57:38.563] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:38.563] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:40:0) after 1m0s
[22:58:38.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:40:0)
[22:58:38.672] Timer tick, asking Buildbucket for the build status
[22:58:38.776] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:38.776] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:41:0) after 1m0s
[22:59:38.879] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:41:0)
[22:59:38.879] Timer tick, asking Buildbucket for the build status
[22:59:39.270] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:39.270] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:42:0) after 1m0s
[23:00:39.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:42:0)
[23:00:39.276] Timer tick, asking Buildbucket for the build status
[23:00:39.551] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:39.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:43:0) after 1m0s
[23:01:39.531] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:43:0)
[23:01:39.531] Timer tick, asking Buildbucket for the build status
[23:01:39.728] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:39.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:44:0) after 1m0s
[23:02:40.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:44:0)
[23:02:40.810] Timer tick, asking Buildbucket for the build status
[23:02:40.882] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:40.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:45:0) after 1m0s
[23:03:40.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:45:0)
[23:03:40.959] Timer tick, asking Buildbucket for the build status
[23:03:41.046] Build 8858453781967578816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:41.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:46:0) after 1m0s
[23:04:01.081] Received PubSub notification, asking Buildbucket for the build status
[23:04:01.287] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:41.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:46:0)
[23:04:41.108] Timer tick, asking Buildbucket for the build status
[23:04:41.404] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:41.404] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:48:0) after 1m0s
[23:05:41.458] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:48:0)
[23:05:41.458] Timer tick, asking Buildbucket for the build status
[23:05:41.553] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:41.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:49:0) after 1m0s
[23:06:41.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:49:0)
[23:06:41.593] Timer tick, asking Buildbucket for the build status
[23:06:41.661] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:41.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:50:0) after 1m0s
[23:07:41.761] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:50:0)
[23:07:41.761] Timer tick, asking Buildbucket for the build status
[23:07:41.881] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:41.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:51:0) after 1m0s
[23:08:41.900] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:51:0)
[23:08:41.900] Timer tick, asking Buildbucket for the build status
[23:08:41.964] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:41.964] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:52:0) after 1m0s
[23:09:41.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:52:0)
[23:09:41.981] Timer tick, asking Buildbucket for the build status
[23:09:42.282] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:42.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:53:0) after 1m0s
[23:10:42.384] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:53:0)
[23:10:42.384] Timer tick, asking Buildbucket for the build status
[23:10:42.767] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:42.767] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:54:0) after 1m0s
[23:11:42.784] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:54:0)
[23:11:42.784] Timer tick, asking Buildbucket for the build status
[23:11:43.031] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:43.031] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:55:0) after 1m0s
[23:12:43.016] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:55:0)
[23:12:43.016] Timer tick, asking Buildbucket for the build status
[23:12:43.082] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:43.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:56:0) after 1m0s
[23:13:43.190] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:56:0)
[23:13:43.190] Timer tick, asking Buildbucket for the build status
[23:13:43.251] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:43.251] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:57:0) after 1m0s
[23:14:43.246] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:57:0)
[23:14:43.246] Timer tick, asking Buildbucket for the build status
[23:14:43.347] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:43.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:58:0) after 1m0s
[23:15:43.399] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:58:0)
[23:15:43.399] Timer tick, asking Buildbucket for the build status
[23:15:43.456] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:43.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:59:0) after 1m0s
[23:16:43.475] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:59:0)
[23:16:43.475] Timer tick, asking Buildbucket for the build status
[23:16:43.589] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:43.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:60:0) after 1m0s
[23:17:43.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:60:0)
[23:17:43.607] Timer tick, asking Buildbucket for the build status
[23:17:44.126] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:44.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:61:0) after 1m0s
[23:18:44.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:61:0)
[23:18:44.194] Timer tick, asking Buildbucket for the build status
[23:18:44.248] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:44.248] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:62:0) after 1m0s
[23:19:44.306] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:62:0)
[23:19:44.306] Timer tick, asking Buildbucket for the build status
[23:19:44.900] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:44.900] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:63:0) after 1m0s
[23:20:44.953] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:63:0)
[23:20:44.953] Timer tick, asking Buildbucket for the build status
[23:20:45.011] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:45.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:64:0) after 1m0s
[23:21:45.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:64:0)
[23:21:45.027] Timer tick, asking Buildbucket for the build status
[23:21:45.113] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:45.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:65:0) after 1m0s
[23:22:45.184] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:65:0)
[23:22:45.184] Timer tick, asking Buildbucket for the build status
[23:22:45.389] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:45.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:66:0) after 1m0s
[23:23:45.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:66:0)
[23:23:45.407] Timer tick, asking Buildbucket for the build status
[23:23:45.528] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:45.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:67:0) after 1m0s
[23:24:45.547] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:67:0)
[23:24:45.547] Timer tick, asking Buildbucket for the build status
[23:24:45.907] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:45.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:68:0) after 1m0s
[23:25:45.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:68:0)
[23:25:45.931] Timer tick, asking Buildbucket for the build status
[23:25:46.026] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:46.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:69:0) after 1m0s
[23:26:46.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:69:0)
[23:26:46.112] Timer tick, asking Buildbucket for the build status
[23:26:46.170] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:46.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:70:0) after 1m0s
[23:27:46.226] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:70:0)
[23:27:46.226] Timer tick, asking Buildbucket for the build status
[23:27:46.292] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:46.292] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:71:0) after 1m0s
[23:28:46.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:71:0)
[23:28:46.344] Timer tick, asking Buildbucket for the build status
[23:28:46.536] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:46.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:72:0) after 1m0s
[23:29:46.533] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:72:0)
[23:29:46.533] Timer tick, asking Buildbucket for the build status
[23:29:46.628] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:46.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:73:0) after 1m0s
[23:30:46.652] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:73:0)
[23:30:46.652] Timer tick, asking Buildbucket for the build status
[23:30:46.733] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:46.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:74:0) after 1m0s
[23:31:46.752] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:74:0)
[23:31:46.752] Timer tick, asking Buildbucket for the build status
[23:31:46.850] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:46.850] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:75:0) after 1m0s
[23:32:46.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:75:0)
[23:32:46.890] Timer tick, asking Buildbucket for the build status
[23:32:47.089] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:47.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:76:0) after 1m0s
[23:33:47.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:76:0)
[23:33:47.149] Timer tick, asking Buildbucket for the build status
[23:33:47.204] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:47.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:77:0) after 1m0s
[23:34:47.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:77:0)
[23:34:47.293] Timer tick, asking Buildbucket for the build status
[23:34:47.382] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:47.382] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:78:0) after 1m0s
[23:35:47.404] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:78:0)
[23:35:47.404] Timer tick, asking Buildbucket for the build status
[23:35:47.644] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:47.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:79:0) after 1m0s
[23:36:47.681] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:79:0)
[23:36:47.681] Timer tick, asking Buildbucket for the build status
[23:36:48.612] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:48.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:80:0) after 1m0s
[23:37:48.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:80:0)
[23:37:48.632] Timer tick, asking Buildbucket for the build status
[23:37:48.683] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:48.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:81:0) after 1m0s
[23:38:48.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:81:0)
[23:38:48.714] Timer tick, asking Buildbucket for the build status
[23:38:48.794] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:48.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:82:0) after 1m0s
[23:39:48.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:82:0)
[23:39:48.810] Timer tick, asking Buildbucket for the build status
[23:39:48.915] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:48.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:83:0) after 1m0s
[23:40:48.932] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:83:0)
[23:40:48.932] Timer tick, asking Buildbucket for the build status
[23:40:48.987] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:48.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:84:0) after 1m0s
[23:41:49.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:84:0)
[23:41:49.032] Timer tick, asking Buildbucket for the build status
[23:41:49.094] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:49.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:85:0) after 1m0s
[23:42:49.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:85:0)
[23:42:49.167] Timer tick, asking Buildbucket for the build status
[23:42:49.246] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:49.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:86:0) after 1m0s
[23:43:49.319] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:86:0)
[23:43:49.319] Timer tick, asking Buildbucket for the build status
[23:43:49.428] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:49.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:87:0) after 1m0s
[23:44:49.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:87:0)
[23:44:49.506] Timer tick, asking Buildbucket for the build status
[23:44:49.619] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:49.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:88:0) after 1m0s
[23:45:49.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:88:0)
[23:45:49.644] Timer tick, asking Buildbucket for the build status
[23:45:49.709] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:49.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:89:0) after 1m0s
[23:46:49.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:89:0)
[23:46:49.730] Timer tick, asking Buildbucket for the build status
[23:46:49.778] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:49.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:90:0) after 1m0s
[23:47:49.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:90:0)
[23:47:49.801] Timer tick, asking Buildbucket for the build status
[23:47:51.884] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:51.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:91:0) after 1m0s
[23:48:51.932] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:91:0)
[23:48:51.932] Timer tick, asking Buildbucket for the build status
[23:48:52.003] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:52.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:92:0) after 1m0s
[23:49:52.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:92:0)
[23:49:52.350] Timer tick, asking Buildbucket for the build status
[23:49:52.530] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:52.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:93:0) after 1m0s
[23:50:52.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:93:0)
[23:50:52.600] Timer tick, asking Buildbucket for the build status
[23:50:52.842] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:52.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:94:0) after 1m0s
[23:51:52.867] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:94:0)
[23:51:52.867] Timer tick, asking Buildbucket for the build status
[23:51:53.025] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:53.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:95:0) after 1m0s
[23:52:53.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:95:0)
[23:52:53.068] Timer tick, asking Buildbucket for the build status
[23:52:53.139] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:53.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:96:0) after 1m0s
[23:53:53.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:96:0)
[23:53:53.267] Timer tick, asking Buildbucket for the build status
[23:53:53.350] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:53.350] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:97:0) after 1m0s
[23:54:53.375] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:97:0)
[23:54:53.375] Timer tick, asking Buildbucket for the build status
[23:54:53.492] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:53.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:98:0) after 1m0s
[23:55:53.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:98:0)
[23:55:53.524] Timer tick, asking Buildbucket for the build status
[23:55:53.580] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:53.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:99:0) after 1m0s
[23:56:53.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:99:0)
[23:56:53.641] Timer tick, asking Buildbucket for the build status
[23:56:55.506] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:55.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:100:0) after 1m0s
[23:57:55.581] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:100:0)
[23:57:55.581] Timer tick, asking Buildbucket for the build status
[23:57:55.668] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:55.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:101:0) after 1m0s
[23:58:55.718] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:101:0)
[23:58:55.718] Timer tick, asking Buildbucket for the build status
[23:58:55.837] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:55.837] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:102:0) after 1m0s
[23:59:55.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:102:0)
[23:59:55.843] Timer tick, asking Buildbucket for the build status
[23:59:55.965] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:55.965] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:103:0) after 1m0s
[00:00:55.987] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:103:0)
[00:00:55.987] Timer tick, asking Buildbucket for the build status
[00:00:56.068] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:56.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:104:0) after 1m0s
[00:01:56.051] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:104:0)
[00:01:56.051] Timer tick, asking Buildbucket for the build status
[00:01:56.108] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:56.108] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:105:0) after 1m0s
[00:02:56.123] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:105:0)
[00:02:56.123] Timer tick, asking Buildbucket for the build status
[00:02:56.227] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:56.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:106:0) after 1m0s
[00:03:56.249] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:106:0)
[00:03:56.249] Timer tick, asking Buildbucket for the build status
[00:03:57.522] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:57.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:107:0) after 1m0s
[00:04:57.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:107:0)
[00:04:57.550] Timer tick, asking Buildbucket for the build status
[00:04:57.667] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:57.667] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:108:0) after 1m0s
[00:05:57.758] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:108:0)
[00:05:57.758] Timer tick, asking Buildbucket for the build status
[00:05:58.214] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:58.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:109:0) after 1m0s
[00:06:58.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:109:0)
[00:06:58.213] Timer tick, asking Buildbucket for the build status
[00:06:58.276] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:58.276] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:110:0) after 1m0s
[00:07:58.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:110:0)
[00:07:58.393] Timer tick, asking Buildbucket for the build status
[00:07:58.932] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:58.932] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:111:0) after 1m0s
[00:08:58.987] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:111:0)
[00:08:58.987] Timer tick, asking Buildbucket for the build status
[00:08:59.058] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:59.058] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:112:0) after 1m0s
[00:09:59.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:112:0)
[00:09:59.106] Timer tick, asking Buildbucket for the build status
[00:09:59.252] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:59.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:113:0) after 1m0s
[00:10:59.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:113:0)
[00:10:59.318] Timer tick, asking Buildbucket for the build status
[00:10:59.391] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:59.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:114:0) after 1m0s
[00:11:59.482] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:114:0)
[00:11:59.482] Timer tick, asking Buildbucket for the build status
[00:11:59.623] Build 8858453781967578816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:59.623] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023883843866160544:115:0) after 1m0s
[00:12:46.755] Received PubSub notification, asking Buildbucket for the build status
[00:12:46.826] Build 8858453781967578816: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:12:46.826] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610323965650368",
"created_by": "project:chromium",
"created_ts": "1610317167273788",
"id": "8858453781967578816",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e9fe59463e3d72c72f22306738c412a175164826\"}}",
"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\": \"e9fe59463e3d72c72f22306738c412a175164826\", \"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-128-r3v6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 179507, \"got_angle_revision\": \"0b90eef09f607336330f318bc8e65fa981634160\", \"got_dawn_revision\": \"3a0405597374c9ae12fb93e33aac35826455a958\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"e9fe59463e3d72c72f22306738c412a175164826\", \"got_revision_cp\": \"refs/heads/master@{#841903}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"348ba200aa29d5b3a36d696d48d8f619e055219f\", \"got_v8_revision\": \"5d60a181de0863d8d00ae42ec0ee3521f51b501a\", \"got_v8_revision_cp\": \"refs/heads/8.9.229@{#1}\", \"got_webrtc_revision\": \"42082f9045e74e65b9e3a66b51093e0dc2f9375a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32929}\", \"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\": \"e9fe59463e3d72c72f22306738c412a175164826\", \"swarm_hashes_refs/heads/master(at){#841903}_without_patch\": {\"absl_hardening_tests\": \"55a7597b339cde3393cc4e8006a84704579b63a7\", \"accessibility_unittests\": \"05682f07687b762f81e51b51f941d2ee48da3ba3\", \"angle_unittests\": \"2ee359a8b24246bb777857a8d6ddc98ab206f872\", \"app_shell_unittests\": \"bf72a0d9b46985c1c0e812df5dcd9181e463dc19\", \"aura_unittests\": \"878cf71b287bb56540cb203b2b079374e22ae6be\", \"base_unittests\": \"87a412fe2308270cca48169f09d464dbe9cab669\", \"base_util_unittests\": \"d29945e928edf931b674caa4ffcdad7f37914172\", \"blink_common_unittests\": \"1b448aff05595ca88991336663a06741730533a7\", \"blink_fuzzer_unittests\": \"d7b7f4e221e8888f18eacbbb27da783ab772a0f6\", \"blink_heap_unittests\": \"f57a47a7c8452d0d23cfe9369f3ab42aca5ca6f9\", \"blink_platform_unittests\": \"6a3796fafee66989ddad5bdb932ac041f2708551\", \"blink_python_tests\": \"aad54347d2487f4d8cdd16952777901acd8801fd\", \"blink_unittests\": \"17eaf4d554b25bc007738e491fb531a2541df091\", \"blink_web_tests\": \"e3a04eec1762d1f21d3c29cf651f1424b2b3348b\", \"boringssl_crypto_tests\": \"566e837479c458df63455cf38c32cecd0c7fb989\", \"boringssl_ssl_tests\": \"d94136da340022f59b76733f2e8257b3bf8810e6\", \"browser_tests\": \"9a912ea45e7e385007aaadf0a7f9db1ec1c692fb\", \"capture_unittests\": \"cc0393ef5f75af115a905bfa6f8ee00a9a58b176\", \"cast_unittests\": \"d08a097b036d08c8b75c6a71b1d94ca081ca360e\", \"cc_unittests\": \"0d0dc8b3591217dd77e247dc7490677975fc8f14\", \"chrome_app_unittests\": \"46350d403c6011e4848a67b2a7add73e7e37c87b\", \"chromedriver_unittests\": \"014b9cccf6ed9e4e55e2f651b340deab3b014d75\", \"components_browsertests\": \"23399306fe5ed258964280c52a84ca4136af26da\", \"components_unittests\": \"dd1559dcf3936a75a146967c8da75a468fd017e0\", \"compositor_unittests\": \"575691fc4f97bbfaba5dbf7852505ad70d4243c0\", \"content_browsertests\": \"feeb18f85ca159de711a1b2d0134024b0ef058dd\", \"content_shell_crash_test\": \"73acd84e9007cb36c1a13a371a2ca8d9a7d24b8e\", \"content_unittests\": \"432da00b72de8d5e31e7617e51758f4a81a7f93b\", \"crashpad_tests\": \"6f4278176bbaa5faa9b4b05529b3babe1aa20c82\", \"cronet_tests\": \"c1d3c1f823e8320f33c5c35feea1ed9441307564\", \"cronet_unittests\": \"1015d14faf4af87f4895a6bf04871925b4e4493a\", \"crypto_unittests\": \"c592ad4d1b63785b8a0dd27bed1de43d73c77d89\", \"dbus_unittests\": \"20b690c16a5fe3b8b2787f5af4e00d1d44675784\", \"device_unittests\": \"cbf2815a2ccff32026a99b24eb070770360daac9\", \"display_unittests\": \"ffbbf9c795a6276ba138923b11815a8cd7bf7dfa\", \"events_unittests\": \"81e09a8b88fc15a0b28639d026db10ac46610c08\", \"extensions_browsertests\": \"6b868e03b959b8583ec557d000928a0d749af9bb\", \"extensions_unittests\": \"d80bb32bb05ec1b5a5e9c0c518e3f9995330fff6\", \"filesystem_service_unittests\": \"e1b41cfaa3669a37b8affaa1f6757e963195f724\", \"flatbuffers_unittests\": \"cc869a2fbd06ae1fab18c809541dec3b75d7db1a\", \"gcm_unit_tests\": \"56b1b9735947ca25f0fc3f77e535972c679e90c0\", \"gfx_unittests\": \"08b4b8583120391e5a45ad80d3ccc326bfc3f680\", \"gin_unittests\": \"8be11cfec03df1b73ea6fd37e001f2c2fb1babb0\", \"google_apis_unittests\": \"55f6e809f4200f06027a1cb3c9941c38724b5f4a\", \"gpu_unittests\": \"0f81f0599f2efd384c8a0cfa03136ff19629a05c\", \"grit_python_unittests\": \"0718a5373aa0ae8758877d63c90aad8024074ace\", \"gwp_asan_unittests\": \"c5159b1deaa4a6625543632b2f3c1de98e162ba9\", \"headless_browsertests\": \"9eb9efe6df263847d892b8b051b0a83176d0b17e\", \"headless_unittests\": \"f18e745caa327d7c5d59c1118c30c8fb3cfb8b56\", \"interactive_ui_tests\": \"4b9600835b57fa29ebd36f5adfa480597abc6bf3\", \"ipc_tests\": \"be2f76380e0a9401e4b0fcc5102640fc5b0342eb\", \"jingle_unittests\": \"4bcf38212fc0e47eed5c443015932756bb065a6d\", \"latency_unittests\": \"4c74be54c7ac1a4ecf450e2217fbd566dcc51900\", \"libjingle_xmpp_unittests\": \"2a8cc438437b51cdadf68364431b2f6c247e122c\", \"liburlpattern_unittests\": \"2fa87b1545579432d0344fb6aa4794c653cacbbb\", \"media_blink_unittests\": \"f52c0c8eaf732e10c2445f8bf631dd395786cebc\", \"media_unittests\": \"2faf5c8b60fec64b8ad05c282351d288f20c649b\", \"message_center_unittests\": \"dfefb169457de0b83efff068fe1f33f79466bf89\", \"metrics_python_tests\": \"3754d2123641e69839e1df07b30ef8dd043f26b5\", \"midi_unittests\": \"ac5c39060f2673c5ebf22f1b052f5d43d8fe6cdf\", \"mojo_core_unittests\": \"abf6135c90251dcd7955b7a9d4353375da1544bb\", \"mojo_unittests\": \"8af6a5684cf41061c49d1ec50dec6724f0e5eda7\", \"nacl_helper_nonsfi_unittests\": \"c544dff9294a22a14876646c85d0ad6d3982f774\", \"nacl_loader_unittests\": \"eb932e0f8f8e41544c51ac50258064d5df479033\", \"native_theme_unittests\": \"63e383943bd32c337d792b792b15e09fdb7ed395\", \"net_unittests\": \"d810916c16535ac915deb8eb4a40fa6f0a9d6fd3\", \"openscreen_unittests\": \"edca1325a5f04c51be6cc4a21cfd462e42f5d0d5\", \"pdf_unittests\": \"dc97977e5e175c068c0ca5f63a2db87db1cb380a\", \"perfetto_unittests\": \"52b3a5a0cefa475512ad92b11222283056122f8a\", \"ppapi_unittests\": \"caf7c568d030ec5454fac736d40b1ba0d02b9fca\", \"printing_unittests\": \"30e7b53517588917e3199795482518eccf7ee6df\", \"remoting_unittests\": \"eb70266d3b67fe8eca17280280b05ec7bc3fa366\", \"sandbox_linux_unittests\": \"573643cce200d917020fea5cb3d6a927515097a5\", \"service_manager_unittests\": \"c260fa1384b4332ba77e293bf741ad4be499d8a7\", \"services_unittests\": \"ed76f2406678622820d0a8c27e47a5462d798453\", \"shell_dialogs_unittests\": \"fcf41ee600646828b5e1f0c63c726fb67e1acf12\", \"skia_unittests\": \"15eaa26db95d1a7cda2c1a7c0fb0563d659a179f\", \"snapshot_unittests\": \"cd15812d6de4744ffdfb24bf439096cc2ba518eb\", \"sql_unittests\": \"218efa61d7320b3b2410b00148031a4d0fb36c89\", \"storage_unittests\": \"3c717ecd8d6ac93661f60f61dd4ada3e149a61c8\", \"sync_integration_tests\": \"136b61c21dad3391440e1a952faf306a707d08b9\", \"telemetry_gpu_unittests\": \"ca44557935530f942784e306db4b62c6a21661f0\", \"telemetry_perf_unittests\": \"6a652d527754c9471ebd3427913856cef3ad5def\", \"telemetry_unittests\": \"d071904cda99e97f155e6494b01f0f5809a25e7a\", \"traffic_annotation_auditor_unittests\": \"aab889ea5da3eefe41c80074b301c8d1065a7c61\", \"ui_base_unittests\": \"ea6ff8605289eede8370db9b2b39b18d9e5ff1b7\", \"ui_touch_selection_unittests\": \"a4243d174a46f995cb5e009035b783f5581753f8\", \"unit_tests\": \"09f07cb9a726055b8496612b16fa2af3750aa61c\", \"url_unittests\": \"e0b193c356425f1c8a382f7497991aab989dc945\", \"views_perftests\": \"fe31e889ecceb1081766c24b673840292f3a08cf\", \"views_unittests\": \"4b1625d1ba600b20a48c9c9b4487c9db28d8170c\", \"viz_unittests\": \"a0735d7aacc780ae32711b993c4611aa68f8648f\", \"vr_common_unittests\": \"8b0c696e4e87497ca286189c4bd742ed223f67b6\", \"vr_pixeltests\": \"7bf8eef4cd6e6463774ab08166c5c0b5a7ee51c2\", \"webdriver_wpt_tests\": \"022eb4993e8af9778db7d67dbc55f6a0556056b1\", \"weblayer_browsertests\": \"f1f420b2830ee7ffe858b8c8b55575a5b11fd236\", \"weblayer_unittests\": \"53417d22727808aaf8284ed83bafb735574b5f46\", \"wm_unittests\": \"946100d39ef6a9e83775501c37663d03ab0596d4\", \"wtf_unittests\": \"4497ccd86459f0ecf6b42b7e60c0fa7909ea7b5c\", \"x11_unittests\": \"7c7cd0a76915bbd18d5407d11afed2ee75bd1475\", \"xr_browser_tests\": \"587e189ec6fc8fcd07b2e874d1e91271425fc7a8\", \"zlib_unittests\": \"7b166e3bfff8f96bf4be74874f130da6ed5c9d6e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-128-r3v6\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"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": "1610319825127772",
"status": "COMPLETED",
"status_changed_ts": "1610323966065951",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179507",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e9fe59463e3d72c72f22306738c412a175164826",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e9fe59463e3d72c72f22306738c412a175164826",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023883843866160544",
"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/8858453781967578816/+/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:51073386025b3810",
"user_agent:luci-scheduler"
],
"updated_ts": "1610323966071853",
"url": "https://ci.chromium.org/b/8858453781967578816",
"utcnow_ts": "1610323966817926"
}
}
[00:12:46.826] Invocation finished in 1h53m20.747022528s with status SUCCEEDED