[16:40:54.358] New invocation is queued and will start shortly
[16:40:55.494] Starting the invocation (attempt 1)
[16:40:55.531] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:40:55.531] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:40:55.531] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028344393622997936",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5ed21d6d592a568c0e913ce42e7b842e903e9fee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9028344393622997936",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/5ed21d6d592a568c0e913ce42e7b842e903e9fee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5ed21d6d592a568c0e913ce42e7b842e903e9fee",
"gitiles_ref:refs/heads/master"
]
}
[16:40:56.098] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606063255602099",
"id": "8862914331652080592",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5ed21d6d592a568c0e913ce42e7b842e903e9fee\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606063255970330",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177914",
"builder:Linux Builder (dbg)",
"buildset:commit/git/5ed21d6d592a568c0e913ce42e7b842e903e9fee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5ed21d6d592a568c0e913ce42e7b842e903e9fee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028344393622997936",
"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/8862914331652080592/+/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": "1606063255970440",
"url": "https://ci.chromium.org/b/8862914331652080592",
"utcnow_ts": "1606063256090302"
}
}
[16:40:56.098] Task URL: https://ci.chromium.org/b/8862914331652080592
[16:40:56.098] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:2:0) after 1m0s
[16:41:56.223] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:2:0)
[16:41:56.223] Timer tick, asking Buildbucket for the build status
[16:41:56.538] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:41:56.539] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:3:0) after 1m0s
[16:42:56.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:3:0)
[16:42:56.560] Timer tick, asking Buildbucket for the build status
[16:42:56.685] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:42:56.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:4:0) after 1m0s
[16:43:56.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:4:0)
[16:43:56.711] Timer tick, asking Buildbucket for the build status
[16:43:56.775] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:43:56.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:5:0) after 1m0s
[16:44:56.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:5:0)
[16:44:56.796] Timer tick, asking Buildbucket for the build status
[16:44:56.951] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:44:56.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:6:0) after 1m0s
[16:45:56.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:6:0)
[16:45:56.976] Timer tick, asking Buildbucket for the build status
[16:45:57.078] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:45:57.078] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:7:0) after 1m0s
[16:46:57.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:7:0)
[16:46:57.103] Timer tick, asking Buildbucket for the build status
[16:46:57.411] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:46:57.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:8:0) after 1m0s
[16:47:57.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:8:0)
[16:47:57.432] Timer tick, asking Buildbucket for the build status
[16:47:57.506] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:47:57.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:9:0) after 1m0s
[16:48:57.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:9:0)
[16:48:57.503] Timer tick, asking Buildbucket for the build status
[16:48:57.736] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:48:57.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:10:0) after 1m0s
[16:49:57.827] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:10:0)
[16:49:57.827] Timer tick, asking Buildbucket for the build status
[16:49:58.046] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:49:58.047] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:11:0) after 1m0s
[16:50:58.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:11:0)
[16:50:58.073] Timer tick, asking Buildbucket for the build status
[16:50:58.251] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:50:58.251] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:12:0) after 1m0s
[16:51:58.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:12:0)
[16:51:58.283] Timer tick, asking Buildbucket for the build status
[16:51:58.352] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:51:58.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:13:0) after 1m0s
[16:52:58.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:13:0)
[16:52:58.372] Timer tick, asking Buildbucket for the build status
[16:52:58.443] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:52:58.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:14:0) after 1m0s
[16:53:58.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:14:0)
[16:53:58.507] Timer tick, asking Buildbucket for the build status
[16:53:58.575] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:53:58.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:15:0) after 1m0s
[16:54:58.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:15:0)
[16:54:58.576] Timer tick, asking Buildbucket for the build status
[16:54:58.654] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:54:58.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:16:0) after 1m0s
[16:55:58.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:16:0)
[16:55:58.706] Timer tick, asking Buildbucket for the build status
[16:55:58.803] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:55:58.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:17:0) after 1m0s
[16:56:58.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:17:0)
[16:56:58.835] Timer tick, asking Buildbucket for the build status
[16:56:58.912] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:56:58.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:18:0) after 1m0s
[16:57:58.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:18:0)
[16:57:58.992] Timer tick, asking Buildbucket for the build status
[16:57:59.408] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:57:59.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:19:0) after 1m0s
[16:58:59.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:19:0)
[16:58:59.477] Timer tick, asking Buildbucket for the build status
[16:58:59.548] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:58:59.548] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:20:0) after 1m0s
[16:59:59.585] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:20:0)
[16:59:59.585] Timer tick, asking Buildbucket for the build status
[16:59:59.716] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:59:59.716] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:21:0) after 1m0s
[17:00:59.737] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:21:0)
[17:00:59.737] Timer tick, asking Buildbucket for the build status
[17:00:59.822] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:00:59.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:22:0) after 1m0s
[17:02:00.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:22:0)
[17:02:00.474] Timer tick, asking Buildbucket for the build status
[17:02:00.579] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:02:00.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:23:0) after 1m0s
[17:03:00.746] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:23:0)
[17:03:00.746] Timer tick, asking Buildbucket for the build status
[17:03:00.821] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:03:00.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:24:0) after 1m0s
[17:04:01.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:24:0)
[17:04:01.520] Timer tick, asking Buildbucket for the build status
[17:04:01.594] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:04:01.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:25:0) after 1m0s
[17:05:01.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:25:0)
[17:05:01.931] Timer tick, asking Buildbucket for the build status
[17:05:02.008] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:05:02.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:26:0) after 1m0s
[17:06:02.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:26:0)
[17:06:02.193] Timer tick, asking Buildbucket for the build status
[17:06:02.295] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:06:02.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:27:0) after 1m0s
[17:07:02.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:27:0)
[17:07:02.373] Timer tick, asking Buildbucket for the build status
[17:07:02.479] Build 8862914331652080592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:07:02.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:28:0) after 1m0s
[17:07:41.751] Received PubSub notification, asking Buildbucket for the build status
[17:07:41.815] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:02.531] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:28:0)
[17:08:02.531] Timer tick, asking Buildbucket for the build status
[17:08:02.595] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:02.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:30:0) after 1m0s
[17:09:02.647] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:30:0)
[17:09:02.647] Timer tick, asking Buildbucket for the build status
[17:09:02.711] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:02.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:31:0) after 1m0s
[17:10:02.841] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:31:0)
[17:10:02.841] Timer tick, asking Buildbucket for the build status
[17:10:03.096] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:03.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:32:0) after 1m0s
[17:11:03.197] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:32:0)
[17:11:03.197] Timer tick, asking Buildbucket for the build status
[17:11:03.297] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:03.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:33:0) after 1m0s
[17:12:03.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:33:0)
[17:12:03.326] Timer tick, asking Buildbucket for the build status
[17:12:03.415] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:03.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:34:0) after 1m0s
[17:13:03.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:34:0)
[17:13:03.695] Timer tick, asking Buildbucket for the build status
[17:13:03.766] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:03.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:35:0) after 1m0s
[17:14:03.997] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:35:0)
[17:14:03.997] Timer tick, asking Buildbucket for the build status
[17:14:04.083] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:04.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:36:0) after 1m0s
[17:15:04.171] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:36:0)
[17:15:04.171] Timer tick, asking Buildbucket for the build status
[17:15:04.477] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:04.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:37:0) after 1m0s
[17:16:04.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:37:0)
[17:16:04.705] Timer tick, asking Buildbucket for the build status
[17:16:04.809] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:04.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:38:0) after 1m0s
[17:17:04.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:38:0)
[17:17:04.889] Timer tick, asking Buildbucket for the build status
[17:17:04.947] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:04.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:39:0) after 1m0s
[17:18:05.013] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:39:0)
[17:18:05.013] Timer tick, asking Buildbucket for the build status
[17:18:06.960] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:06.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:40:0) after 1m0s
[17:19:06.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:40:0)
[17:19:06.942] Timer tick, asking Buildbucket for the build status
[17:19:07.807] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:07.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:41:0) after 1m0s
[17:20:07.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:41:0)
[17:20:07.837] Timer tick, asking Buildbucket for the build status
[17:20:08.980] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:08.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:42:0) after 1m0s
[17:21:09.013] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:42:0)
[17:21:09.013] Timer tick, asking Buildbucket for the build status
[17:21:09.171] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:09.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:43:0) after 1m0s
[17:22:09.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:43:0)
[17:22:09.339] Timer tick, asking Buildbucket for the build status
[17:22:09.432] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:09.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:44:0) after 1m0s
[17:23:09.500] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:44:0)
[17:23:09.500] Timer tick, asking Buildbucket for the build status
[17:23:09.585] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:09.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:45:0) after 1m0s
[17:24:09.725] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:45:0)
[17:24:09.725] Timer tick, asking Buildbucket for the build status
[17:24:09.846] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:09.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:46:0) after 1m0s
[17:25:09.934] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:46:0)
[17:25:09.934] Timer tick, asking Buildbucket for the build status
[17:25:10.022] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:10.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:47:0) after 1m0s
[17:26:10.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:47:0)
[17:26:10.147] Timer tick, asking Buildbucket for the build status
[17:26:10.259] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:10.259] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:48:0) after 1m0s
[17:27:10.466] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:48:0)
[17:27:10.466] Timer tick, asking Buildbucket for the build status
[17:27:10.880] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:10.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:49:0) after 1m0s
[17:28:10.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:49:0)
[17:28:10.929] Timer tick, asking Buildbucket for the build status
[17:28:11.004] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:11.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:50:0) after 1m0s
[17:29:11.084] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:50:0)
[17:29:11.084] Timer tick, asking Buildbucket for the build status
[17:29:11.173] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:11.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:51:0) after 1m0s
[17:30:11.319] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:51:0)
[17:30:11.319] Timer tick, asking Buildbucket for the build status
[17:30:11.415] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:11.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:52:0) after 1m0s
[17:31:11.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:52:0)
[17:31:11.463] Timer tick, asking Buildbucket for the build status
[17:31:11.577] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:11.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:53:0) after 1m0s
[17:32:11.735] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:53:0)
[17:32:11.735] Timer tick, asking Buildbucket for the build status
[17:32:11.807] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:11.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:54:0) after 1m0s
[17:33:11.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:54:0)
[17:33:11.909] Timer tick, asking Buildbucket for the build status
[17:33:11.985] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:11.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:55:0) after 1m0s
[17:34:12.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:55:0)
[17:34:12.129] Timer tick, asking Buildbucket for the build status
[17:34:12.331] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:12.331] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:56:0) after 1m0s
[17:35:12.451] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:56:0)
[17:35:12.451] Timer tick, asking Buildbucket for the build status
[17:35:12.674] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:12.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:57:0) after 1m0s
[17:36:12.718] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:57:0)
[17:36:12.718] Timer tick, asking Buildbucket for the build status
[17:36:13.113] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:13.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:58:0) after 1m0s
[17:37:13.144] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:58:0)
[17:37:13.144] Timer tick, asking Buildbucket for the build status
[17:37:13.365] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:13.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:59:0) after 1m0s
[17:38:13.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:59:0)
[17:38:13.481] Timer tick, asking Buildbucket for the build status
[17:38:13.552] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:13.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:60:0) after 1m0s
[17:39:13.604] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:60:0)
[17:39:13.604] Timer tick, asking Buildbucket for the build status
[17:39:13.682] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:13.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:61:0) after 1m0s
[17:40:13.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:61:0)
[17:40:13.804] Timer tick, asking Buildbucket for the build status
[17:40:13.863] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:13.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:62:0) after 1m0s
[17:41:13.936] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:62:0)
[17:41:13.936] Timer tick, asking Buildbucket for the build status
[17:41:14.053] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:14.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:63:0) after 1m0s
[17:42:14.114] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:63:0)
[17:42:14.114] Timer tick, asking Buildbucket for the build status
[17:42:14.223] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:14.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:64:0) after 1m0s
[17:43:14.211] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:64:0)
[17:43:14.211] Timer tick, asking Buildbucket for the build status
[17:43:14.453] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:14.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:65:0) after 1m0s
[17:44:14.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:65:0)
[17:44:14.541] Timer tick, asking Buildbucket for the build status
[17:44:14.793] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:14.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:66:0) after 1m0s
[17:45:14.811] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:66:0)
[17:45:14.811] Timer tick, asking Buildbucket for the build status
[17:45:14.889] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:14.889] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:67:0) after 1m0s
[17:46:14.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:67:0)
[17:46:14.954] Timer tick, asking Buildbucket for the build status
[17:46:15.056] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:15.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:68:0) after 1m0s
[17:47:15.145] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:68:0)
[17:47:15.145] Timer tick, asking Buildbucket for the build status
[17:47:15.215] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:15.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:69:0) after 1m0s
[17:48:15.587] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:69:0)
[17:48:15.587] Timer tick, asking Buildbucket for the build status
[17:48:15.670] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:15.670] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:70:0) after 1m0s
[17:49:15.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:70:0)
[17:49:15.844] Timer tick, asking Buildbucket for the build status
[17:49:16.051] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:16.051] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:71:0) after 1m0s
[17:50:16.083] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:71:0)
[17:50:16.083] Timer tick, asking Buildbucket for the build status
[17:50:16.273] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:16.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:72:0) after 1m0s
[17:51:16.494] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:72:0)
[17:51:16.494] Timer tick, asking Buildbucket for the build status
[17:51:16.614] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:16.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:73:0) after 1m0s
[17:52:16.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:73:0)
[17:52:16.837] Timer tick, asking Buildbucket for the build status
[17:52:16.901] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:16.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:74:0) after 1m0s
[17:53:17.024] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:74:0)
[17:53:17.024] Timer tick, asking Buildbucket for the build status
[17:53:17.092] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:17.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:75:0) after 1m0s
[17:54:17.256] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:75:0)
[17:54:17.256] Timer tick, asking Buildbucket for the build status
[17:54:17.336] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:17.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:76:0) after 1m0s
[17:55:17.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:76:0)
[17:55:17.481] Timer tick, asking Buildbucket for the build status
[17:55:17.551] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:17.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:77:0) after 1m0s
[17:56:17.794] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:77:0)
[17:56:17.794] Timer tick, asking Buildbucket for the build status
[17:56:17.910] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:17.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:78:0) after 1m0s
[17:57:18.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:78:0)
[17:57:18.028] Timer tick, asking Buildbucket for the build status
[17:57:18.124] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:18.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:79:0) after 1m0s
[17:58:18.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:79:0)
[17:58:18.339] Timer tick, asking Buildbucket for the build status
[17:58:18.404] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:18.404] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:80:0) after 1m0s
[17:59:18.426] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:80:0)
[17:59:18.426] Timer tick, asking Buildbucket for the build status
[17:59:18.482] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:18.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:81:0) after 1m0s
[18:00:18.636] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:81:0)
[18:00:18.636] Timer tick, asking Buildbucket for the build status
[18:00:19.182] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:19.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:82:0) after 1m0s
[18:01:19.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:82:0)
[18:01:19.418] Timer tick, asking Buildbucket for the build status
[18:01:19.634] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:19.634] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:83:0) after 1m0s
[18:02:19.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:83:0)
[18:02:19.924] Timer tick, asking Buildbucket for the build status
[18:02:20.178] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:20.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:84:0) after 1m0s
[18:03:20.315] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:84:0)
[18:03:20.315] Timer tick, asking Buildbucket for the build status
[18:03:20.516] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:20.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:85:0) after 1m0s
[18:04:20.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:85:0)
[18:04:20.630] Timer tick, asking Buildbucket for the build status
[18:04:20.707] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:20.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:86:0) after 1m0s
[18:05:20.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:86:0)
[18:05:20.833] Timer tick, asking Buildbucket for the build status
[18:05:20.911] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:20.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:87:0) after 1m0s
[18:06:20.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:87:0)
[18:06:20.991] Timer tick, asking Buildbucket for the build status
[18:06:21.170] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:21.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:88:0) after 1m0s
[18:07:21.317] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:88:0)
[18:07:21.317] Timer tick, asking Buildbucket for the build status
[18:07:21.864] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:21.864] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:89:0) after 1m0s
[18:08:21.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:89:0)
[18:08:21.979] Timer tick, asking Buildbucket for the build status
[18:08:22.422] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:22.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:90:0) after 1m0s
[18:09:22.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:90:0)
[18:09:22.523] Timer tick, asking Buildbucket for the build status
[18:09:22.598] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:22.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:91:0) after 1m0s
[18:10:22.689] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:91:0)
[18:10:22.689] Timer tick, asking Buildbucket for the build status
[18:10:22.792] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:22.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:92:0) after 1m0s
[18:11:22.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:92:0)
[18:11:22.918] Timer tick, asking Buildbucket for the build status
[18:11:23.030] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:23.030] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:93:0) after 1m0s
[18:12:23.275] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:93:0)
[18:12:23.275] Timer tick, asking Buildbucket for the build status
[18:12:23.380] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:23.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:94:0) after 1m0s
[18:13:23.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:94:0)
[18:13:23.480] Timer tick, asking Buildbucket for the build status
[18:13:23.863] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:23.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:95:0) after 1m0s
[18:14:23.892] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:95:0)
[18:14:23.892] Timer tick, asking Buildbucket for the build status
[18:14:24.016] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:24.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:96:0) after 1m0s
[18:15:24.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:96:0)
[18:15:24.039] Timer tick, asking Buildbucket for the build status
[18:15:24.139] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:24.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:97:0) after 1m0s
[18:16:24.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:97:0)
[18:16:24.157] Timer tick, asking Buildbucket for the build status
[18:16:24.260] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:24.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:98:0) after 1m0s
[18:17:24.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:98:0)
[18:17:24.418] Timer tick, asking Buildbucket for the build status
[18:17:24.520] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:24.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:99:0) after 1m0s
[18:18:24.613] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:99:0)
[18:18:24.613] Timer tick, asking Buildbucket for the build status
[18:18:24.686] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:24.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:100:0) after 1m0s
[18:19:24.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:100:0)
[18:19:24.722] Timer tick, asking Buildbucket for the build status
[18:19:24.785] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:24.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:101:0) after 1m0s
[18:20:24.882] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:101:0)
[18:20:24.882] Timer tick, asking Buildbucket for the build status
[18:20:25.076] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:25.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:102:0) after 1m0s
[18:21:25.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:102:0)
[18:21:25.257] Timer tick, asking Buildbucket for the build status
[18:21:25.365] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:25.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:103:0) after 1m0s
[18:22:25.361] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:103:0)
[18:22:25.361] Timer tick, asking Buildbucket for the build status
[18:22:26.242] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:26.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:104:0) after 1m0s
[18:23:26.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:104:0)
[18:23:26.302] Timer tick, asking Buildbucket for the build status
[18:23:26.416] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:26.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:105:0) after 1m0s
[18:24:26.499] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:105:0)
[18:24:26.499] Timer tick, asking Buildbucket for the build status
[18:24:26.583] Build 8862914331652080592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:26.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028344393622997936:106:0) after 1m0s
[18:24:48.110] Received PubSub notification, asking Buildbucket for the build status
[18:24:48.254] Build 8862914331652080592: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:24:48.254] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606069486463644",
"created_by": "project:chromium",
"created_ts": "1606063255602099",
"id": "8862914331652080592",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5ed21d6d592a568c0e913ce42e7b842e903e9fee\"}}",
"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\": \"5ed21d6d592a568c0e913ce42e7b842e903e9fee\", \"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-85-r62f\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177914, \"got_angle_revision\": \"ebf890fcf9f3e297dcb0736b31bce3e63d63c4d7\", \"got_dawn_revision\": \"546a7c98c89718f2dadf1ae07088fa7cf2ccb53f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"5ed21d6d592a568c0e913ce42e7b842e903e9fee\", \"got_revision_cp\": \"refs/heads/master@{#830047}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"6d612051c083238db89541be4fbb2d624a9baef4\", \"got_v8_revision\": \"805e8b5987e5fd07adbe998f0c21f84cb20468b8\", \"got_v8_revision_cp\": \"refs/heads/8.9.32@{#1}\", \"got_webrtc_revision\": \"d96634781e537685496ce6e207bf41b4a98de492\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32661}\", \"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\": \"5ed21d6d592a568c0e913ce42e7b842e903e9fee\", \"swarm_hashes_refs/heads/master(at){#830047}_without_patch\": {\"absl_hardening_tests\": \"f230be7c7c414ae108a264661edadb5bc6c02700\", \"accessibility_unittests\": \"5a7902c2db09d5c4c470e78a0fee29b61c9f0d7a\", \"angle_unittests\": \"c6132a138bb3610f24ffc9338696fd46cebb821e\", \"app_shell_unittests\": \"20527a5ea2dcc36c03e5349678a682e9c761578c\", \"aura_unittests\": \"254def5cc15f9ed8f112f58905911a1159f11290\", \"base_unittests\": \"5495d5d21b3f1cf5f292a9decbe8fcbbd7ddec9c\", \"base_util_unittests\": \"ac2e272a7697da614f5f4806e6c2b0d2ce4a1489\", \"blink_common_unittests\": \"65a195d38f52b3e65ce62db8e807fe633b95e7d4\", \"blink_fuzzer_unittests\": \"9c7ce2efdb8c6872611231cbc8abff3b1a722ec6\", \"blink_heap_unittests\": \"1ea0b0c8b7f31e5eca73dc09e9542cf4ce586a8a\", \"blink_platform_unittests\": \"6d2d4d9441e509151f04c254a65f26f0f2b1f23f\", \"blink_python_tests\": \"2fa9b75fbaf2107042859b8faca203d6aa8df022\", \"blink_unittests\": \"e652c5bfac618b6750bf277979f5605e59155304\", \"blink_web_tests\": \"4f1d208a774ded411298ddc6c1d38636bca5c3fd\", \"boringssl_crypto_tests\": \"681225ee260342e3613837a037c9de5371b0ac04\", \"boringssl_ssl_tests\": \"536df60b5226ff17910f4e6525f312238f92b7da\", \"browser_tests\": \"781bc490ea7b7d22954c6e8dbc8efd45076bcfa1\", \"capture_unittests\": \"da6996dbaf6b9788fa0b903cdb16d47e56b394d9\", \"cast_unittests\": \"d62500bbe9c54f4d245b9304efa2ffe821b176f5\", \"cc_unittests\": \"46b5af4bc1408f603ff2ad7ab1f8fb71f9382a9a\", \"chrome_app_unittests\": \"281845efe6bca023beac0b5bec6af59499d8815f\", \"chromedriver_unittests\": \"b60b3516c400ed4ae8d55179d0d9ab75b9d3392a\", \"components_browsertests\": \"eb6a553dcd2e51012f8467bdc4e6ef60702ca592\", \"components_unittests\": \"33facad19327aab118b0aa9257229d280716627b\", \"compositor_unittests\": \"694b11f26f664c68ac0f4997f90ef5baf00ea88b\", \"content_browsertests\": \"c412c71754d50cf6fae1f97f89d3574b41a704e9\", \"content_shell_crash_test\": \"3a3a0047f466d186c45f8976d988d9bd04f457a8\", \"content_unittests\": \"bc8995336de32dadb23ad87bdcb85b386d100a18\", \"crashpad_tests\": \"92aa998ce4e1e8a303c8252deb21d44f59b59d36\", \"cronet_tests\": \"1f9c0590a6dba2f615ca1a28070783e5d7f9cbb7\", \"cronet_unittests\": \"4c3d5cac9918b4086d01e32a5d19347c139e172d\", \"crypto_unittests\": \"32c701212b5dc4d65f7789c962c2e90a0893c7f5\", \"dbus_unittests\": \"1ddd7a1826c4b0c65cf864ef28f40b54bfc567d7\", \"device_unittests\": \"9a242f8535b3d5fd4d6dafa362c365c1ff23f524\", \"display_unittests\": \"7edd49dd3fce539e5d978025190094f5dc55637a\", \"events_unittests\": \"b4e610d19756e755256f6a20187fd2a9a6a177a9\", \"extension_docserver_python_unittests\": \"3f97f9b3ffee18736eb04c3a3bfc00004b62b489\", \"extensions_browsertests\": \"e69007d5e56740002f7c224cd96ca4005652b038\", \"extensions_unittests\": \"e11143e1fb668d2a2b8f3067f699c07c1dbc9ecd\", \"filesystem_service_unittests\": \"05bd72be97de7b3b7f677b4b053b73d4030e1101\", \"flatbuffers_unittests\": \"dd6267ccaa5ef4f5de95507aa468128ed4c0a477\", \"gcm_unit_tests\": \"d365b3b5b70f8918f8fbeb58babd2f3d80f4b7ee\", \"gfx_unittests\": \"a89993994c111d5cb7b73a89797c342d2d51beff\", \"gin_unittests\": \"14e3f8003cbd22f96257d9ff5da3151799da2e03\", \"google_apis_unittests\": \"c9583848d180b2048301025dd6fea520f33804e7\", \"gpu_unittests\": \"fa621950dc41ccde39a131e9f05b17b0d8e52006\", \"grit_python_unittests\": \"b20d4d77fd059e1da02f2886f0fe402b433cc81c\", \"gwp_asan_unittests\": \"b22cdc023cde90b5398c23d4e704761e7fd521eb\", \"headless_browsertests\": \"e233caf472232ba0271790672969e677c11ba416\", \"headless_unittests\": \"f1de3d6554d91d14a085557a5ad814e82eac86e9\", \"interactive_ui_tests\": \"5c61ec41f7f73241dee6c9330a2a18db775ec84a\", \"ipc_tests\": \"8fb294128ca74b2f21cfcf4422467f96384282ef\", \"jingle_unittests\": \"2091e19b0d9d8c0a80df217a35761e2b5865a104\", \"latency_unittests\": \"ebd1145782a51ab01dc2767c7b3daedd137a0d5d\", \"libjingle_xmpp_unittests\": \"3874cf729c896cf792c2dfc5b6beedff776775e8\", \"liburlpattern_unittests\": \"e5d343f5ea6c02433664d9d668c1804efecf7b50\", \"media_blink_unittests\": \"69c58a301f024941426d54151d4f3ad34b4baf26\", \"media_unittests\": \"1c7bcb66ac5e3673dad2bbcdd95eba3a24e5ce13\", \"message_center_unittests\": \"f584176ee368e655f94e8057cce9cd989caa5dc6\", \"metrics_python_tests\": \"785dcaee5c82a634802f47ed524d717e70759e22\", \"midi_unittests\": \"660ba696690c2a3e0427ee4f7c5402ab62255ac5\", \"mojo_core_unittests\": \"9f08d7b8f677af2239698246731c55122985739f\", \"mojo_unittests\": \"ba968402c26a5dee59099b4a31bcb746c73abbed\", \"nacl_helper_nonsfi_unittests\": \"352fa522fe90f37aea9ae8a328d99a8495399046\", \"nacl_loader_unittests\": \"6ddc87bcde1d9e5525c46d695b023e8001b6dd45\", \"native_theme_unittests\": \"05dd2e1353e160d89e6198aee9de759ff0ad66d9\", \"net_unittests\": \"8bb3339f3fd62dbd224ba10f684f2bfd310ab76c\", \"openscreen_unittests\": \"89e74563e38953fb8dd8903dd5c927cdcd04d20f\", \"pdf_unittests\": \"4b2a2f0ebefdb6aea3c20157a739a6a0a9b612d7\", \"perfetto_unittests\": \"6e33d0881b2add317cd8c4b7bfd01d9af6d34af4\", \"ppapi_unittests\": \"56b142e57de1527a25de5b5f38d7d481d9973c17\", \"printing_unittests\": \"22b589db35c3aef84406c8dd480271b04d75df87\", \"remoting_unittests\": \"e3a9224940c85708c4078773ba0ea4ba101b3e7f\", \"sandbox_linux_unittests\": \"1f3850610f45925b2674db9f17c2eedd3409359d\", \"service_manager_unittests\": \"819009b44249b86ca61af2fd193048f0ee9151eb\", \"services_unittests\": \"5ef51d579765b9c03fe69ef6b80bb2115258b219\", \"shell_dialogs_unittests\": \"5cee08da42dc309f21d001139e9277e8e15ed6d3\", \"skia_unittests\": \"0b83ee69c47f7848756223280d3ea3a85f56675d\", \"snapshot_unittests\": \"012edb4732092403a3da3ca2321f750f2aae1f17\", \"sql_unittests\": \"e7813fccc793bec0d5b7427b41a9d61b6982b008\", \"storage_unittests\": \"a8e02a1744befc0d2099ac09809144909a2299b4\", \"sync_integration_tests\": \"f2265439061add4c6efb9932ee7130c7f45477d7\", \"telemetry_gpu_unittests\": \"8420a496d2f09e573097c274eb98de418e8ce6be\", \"telemetry_perf_unittests\": \"6876b749e87c001c72ee2a20750c80726c3388b5\", \"telemetry_unittests\": \"92fab624651abe99d0148dee45001fc0bb0201b7\", \"traffic_annotation_auditor_unittests\": \"c5787a0851e810922228e85a9872e5915bca530c\", \"ui_base_unittests\": \"7c1ef60a0361c75714c5a9cf95a2d6df87746557\", \"ui_touch_selection_unittests\": \"314cc62cb283c967841d2bce74a20275a17c7c0e\", \"unit_tests\": \"746899c66240a7441c976d1ff34c28bb4f63db0f\", \"url_unittests\": \"47c3c365bc28fa4137eb0381725b6b9eb28376cc\", \"views_perftests\": \"ca320b499bc8682675756c6a7f444125b0b41d1b\", \"views_unittests\": \"709abf652ae4247ef6f7327c3ae6a38cd0564726\", \"viz_unittests\": \"c1a226ca2d714ddd71ed80f475ccfb45d8af329d\", \"vr_common_unittests\": \"712bfd1363381d07132bf0bf664fb2f2db510b57\", \"vr_pixeltests\": \"7bcf95882ac05f0d1c88a1468cc6254cebf83964\", \"webdriver_wpt_tests\": \"79796272195ebd70c217b9aec9b6b790380e581a\", \"weblayer_browsertests\": \"ad23e6998cab51b5c2657b39b6194354b46bfd3c\", \"weblayer_unittests\": \"08387c58856d73e8d87764af2a9ecbd8dbe72d85\", \"wm_unittests\": \"88ad3dca771397d780ca39c370137766b29196f1\", \"wtf_unittests\": \"e12bea87c6fd1ef3aa7c32240bfbdcf728c9bb84\", \"x11_unittests\": \"f4c5cfa3120ddb6a30252d566e74e1b3036e5306\", \"xr_browser_tests\": \"3df5422bc8e40eb3f6b410b6d54055e97de7b5d6\", \"zlib_unittests\": \"af65c26298aa3af97f142a5fbe6007775cf5fdcc\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_112d55e69d4bf792454bf0bc343f5011325dc51aa46e2a4521a4a1f4a6d30164_v2\", \"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_5c906bad1aaeae24a2a7f043536626a3e8df9b2c7401ab4a0dd83c120911bddd_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_9b8e7cf0a756f5448fe63e5ba03689dec6fdccd23b3dfddd2910706476b68383_v2\", \"builder_a10052c67097968898fa29710cdaa0ada58a120001760a536a006ca29eefe964_v2\", \"builder_a849f81f6411318ca1ae7ae9de2e8d97c3f310d4dee80eb425bf1664c9af39e4_v2\", \"builder_b452dbd0948c9cc8e5da17ae2667b73a702b3c833f9453e00f98c9bad535ddc3_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-85-r62f\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606064860647670",
"status": "COMPLETED",
"status_changed_ts": "1606069486746342",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177914",
"builder:Linux Builder (dbg)",
"buildset:commit/git/5ed21d6d592a568c0e913ce42e7b842e903e9fee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5ed21d6d592a568c0e913ce42e7b842e903e9fee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028344393622997936",
"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/8862914331652080592/+/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:5009a5fab968a410",
"user_agent:luci-scheduler"
],
"updated_ts": "1606069486753350",
"url": "https://ci.chromium.org/b/8862914331652080592",
"utcnow_ts": "1606069488244046"
}
}
[18:24:48.254] Invocation finished in 1h43m53.914449584s with status SUCCEEDED