[05:20:47.343] New invocation is queued and will start shortly
[05:20:48.491] Starting the invocation (attempt 1)
[05:20:48.525] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:20:48.525] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:20:48.525] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024582110286431696",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"caf24578f5ada7e553749e11351a7ae7af693929\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9024582110286431696",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/caf24578f5ada7e553749e11351a7ae7af693929",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/caf24578f5ada7e553749e11351a7ae7af693929",
"gitiles_ref:refs/heads/master"
]
}
[05:20:49.397] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609651248671892",
"id": "8859152048231621696",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"caf24578f5ada7e553749e11351a7ae7af693929\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609651249255328",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179274",
"builder:Linux Builder (dbg)",
"buildset:commit/git/caf24578f5ada7e553749e11351a7ae7af693929",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/caf24578f5ada7e553749e11351a7ae7af693929",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024582110286431696",
"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/8859152048231621696/+/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": "1609651249255716",
"url": "https://ci.chromium.org/b/8859152048231621696",
"utcnow_ts": "1609651249390667"
}
}
[05:20:49.397] Task URL: https://ci.chromium.org/b/8859152048231621696
[05:20:49.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:2:0) after 1m0s
[05:21:49.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:2:0)
[05:21:49.386] Timer tick, asking Buildbucket for the build status
[05:21:49.471] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:21:49.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:3:0) after 1m0s
[05:22:49.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:3:0)
[05:22:49.488] Timer tick, asking Buildbucket for the build status
[05:22:49.549] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:22:49.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:4:0) after 1m0s
[05:23:49.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:4:0)
[05:23:49.615] Timer tick, asking Buildbucket for the build status
[05:23:49.706] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:23:49.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:5:0) after 1m0s
[05:24:49.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:5:0)
[05:24:49.785] Timer tick, asking Buildbucket for the build status
[05:24:49.862] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:24:49.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:6:0) after 1m0s
[05:25:49.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:6:0)
[05:25:49.931] Timer tick, asking Buildbucket for the build status
[05:25:50.024] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:25:50.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:7:0) after 1m0s
[05:26:50.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:7:0)
[05:26:50.078] Timer tick, asking Buildbucket for the build status
[05:26:50.165] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:26:50.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:8:0) after 1m0s
[05:27:50.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:8:0)
[05:27:50.291] Timer tick, asking Buildbucket for the build status
[05:27:50.389] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:27:50.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:9:0) after 1m0s
[05:28:50.808] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:9:0)
[05:28:50.808] Timer tick, asking Buildbucket for the build status
[05:28:50.903] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:28:50.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:10:0) after 1m0s
[05:29:51.037] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:10:0)
[05:29:51.037] Timer tick, asking Buildbucket for the build status
[05:29:51.110] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:29:51.110] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:11:0) after 1m0s
[05:30:51.365] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:11:0)
[05:30:51.365] Timer tick, asking Buildbucket for the build status
[05:30:51.568] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:30:51.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:12:0) after 1m0s
[05:31:51.773] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:12:0)
[05:31:51.773] Timer tick, asking Buildbucket for the build status
[05:31:51.835] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:31:51.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:13:0) after 1m0s
[05:32:51.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:13:0)
[05:32:51.889] Timer tick, asking Buildbucket for the build status
[05:32:51.955] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:32:51.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:14:0) after 1m0s
[05:33:52.113] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:14:0)
[05:33:52.113] Timer tick, asking Buildbucket for the build status
[05:33:52.173] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:33:52.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:15:0) after 1m0s
[05:34:52.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:15:0)
[05:34:52.510] Timer tick, asking Buildbucket for the build status
[05:34:52.599] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:34:52.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:16:0) after 1m0s
[05:35:52.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:16:0)
[05:35:52.804] Timer tick, asking Buildbucket for the build status
[05:35:52.914] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:35:52.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:17:0) after 1m0s
[05:36:52.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:17:0)
[05:36:52.952] Timer tick, asking Buildbucket for the build status
[05:36:53.025] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:36:53.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:18:0) after 1m0s
[05:37:53.051] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:18:0)
[05:37:53.051] Timer tick, asking Buildbucket for the build status
[05:37:53.103] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:37:53.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:19:0) after 1m0s
[05:38:53.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:19:0)
[05:38:53.125] Timer tick, asking Buildbucket for the build status
[05:38:53.262] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:38:53.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:20:0) after 1m0s
[05:39:53.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:20:0)
[05:39:53.333] Timer tick, asking Buildbucket for the build status
[05:39:53.413] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:39:53.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:21:0) after 1m0s
[05:40:53.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:21:0)
[05:40:53.454] Timer tick, asking Buildbucket for the build status
[05:40:53.564] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:40:53.564] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:22:0) after 1m0s
[05:41:53.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:22:0)
[05:41:53.621] Timer tick, asking Buildbucket for the build status
[05:41:53.680] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:41:53.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:23:0) after 1m0s
[05:42:53.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:23:0)
[05:42:53.701] Timer tick, asking Buildbucket for the build status
[05:42:53.765] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:42:53.765] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:24:0) after 1m0s
[05:43:53.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:24:0)
[05:43:53.782] Timer tick, asking Buildbucket for the build status
[05:43:53.885] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:43:53.885] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:25:0) after 1m0s
[05:44:53.908] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:25:0)
[05:44:53.908] Timer tick, asking Buildbucket for the build status
[05:44:53.971] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:44:53.971] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:26:0) after 1m0s
[05:45:54.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:26:0)
[05:45:54.000] Timer tick, asking Buildbucket for the build status
[05:45:54.092] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:45:54.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:27:0) after 1m0s
[05:46:54.188] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:27:0)
[05:46:54.188] Timer tick, asking Buildbucket for the build status
[05:46:54.290] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:46:54.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:28:0) after 1m0s
[05:47:54.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:28:0)
[05:47:54.373] Timer tick, asking Buildbucket for the build status
[05:47:54.518] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:47:54.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:29:0) after 1m0s
[05:48:54.499] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:29:0)
[05:48:54.499] Timer tick, asking Buildbucket for the build status
[05:48:54.595] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:48:54.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:30:0) after 1m0s
[05:49:54.668] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:30:0)
[05:49:54.668] Timer tick, asking Buildbucket for the build status
[05:49:54.887] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:49:54.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:31:0) after 1m0s
[05:50:54.965] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:31:0)
[05:50:54.965] Timer tick, asking Buildbucket for the build status
[05:50:55.234] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:50:55.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:32:0) after 1m0s
[05:51:55.253] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:32:0)
[05:51:55.253] Timer tick, asking Buildbucket for the build status
[05:51:55.314] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:51:55.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:33:0) after 1m0s
[05:52:55.328] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:33:0)
[05:52:55.328] Timer tick, asking Buildbucket for the build status
[05:52:55.427] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:52:55.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:34:0) after 1m0s
[05:53:55.456] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:34:0)
[05:53:55.456] Timer tick, asking Buildbucket for the build status
[05:53:55.702] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:53:55.702] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:35:0) after 1m0s
[05:54:55.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:35:0)
[05:54:55.721] Timer tick, asking Buildbucket for the build status
[05:54:56.081] Build 8859152048231621696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:54:56.081] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:36:0) after 1m0s
[05:55:31.021] Received PubSub notification, asking Buildbucket for the build status
[05:55:31.076] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:56.102] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:36:0)
[05:55:56.102] Timer tick, asking Buildbucket for the build status
[05:55:56.181] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:56.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:38:0) after 1m0s
[05:56:56.246] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:38:0)
[05:56:56.246] Timer tick, asking Buildbucket for the build status
[05:56:56.322] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:56.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:39:0) after 1m0s
[05:57:56.359] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:39:0)
[05:57:56.359] Timer tick, asking Buildbucket for the build status
[05:57:56.419] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:56.419] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:40:0) after 1m0s
[05:58:56.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:40:0)
[05:58:56.437] Timer tick, asking Buildbucket for the build status
[05:58:56.530] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:56.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:41:0) after 1m0s
[05:59:56.555] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:41:0)
[05:59:56.556] Timer tick, asking Buildbucket for the build status
[05:59:56.650] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:56.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:42:0) after 1m0s
[06:00:56.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:42:0)
[06:00:56.710] Timer tick, asking Buildbucket for the build status
[06:00:56.855] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:56.855] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:43:0) after 1m0s
[06:01:56.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:43:0)
[06:01:56.843] Timer tick, asking Buildbucket for the build status
[06:01:57.019] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:57.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:44:0) after 1m0s
[06:02:57.046] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:44:0)
[06:02:57.046] Timer tick, asking Buildbucket for the build status
[06:02:57.117] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:57.117] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:45:0) after 1m0s
[06:03:57.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:45:0)
[06:03:57.136] Timer tick, asking Buildbucket for the build status
[06:03:57.505] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:57.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:46:0) after 1m0s
[06:04:57.527] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:46:0)
[06:04:57.527] Timer tick, asking Buildbucket for the build status
[06:04:57.642] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:57.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:47:0) after 1m0s
[06:05:57.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:47:0)
[06:05:57.663] Timer tick, asking Buildbucket for the build status
[06:05:57.803] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:57.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:48:0) after 1m0s
[06:06:57.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:48:0)
[06:06:57.847] Timer tick, asking Buildbucket for the build status
[06:06:57.912] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:57.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:49:0) after 1m0s
[06:07:57.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:49:0)
[06:07:57.933] Timer tick, asking Buildbucket for the build status
[06:07:58.115] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:58.115] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:50:0) after 1m0s
[06:08:58.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:50:0)
[06:08:58.116] Timer tick, asking Buildbucket for the build status
[06:08:58.333] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:58.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:51:0) after 1m0s
[06:09:58.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:51:0)
[06:09:58.351] Timer tick, asking Buildbucket for the build status
[06:09:58.416] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:58.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:52:0) after 1m0s
[06:10:58.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:52:0)
[06:10:58.434] Timer tick, asking Buildbucket for the build status
[06:10:58.551] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:58.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:53:0) after 1m0s
[06:11:58.571] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:53:0)
[06:11:58.571] Timer tick, asking Buildbucket for the build status
[06:11:58.813] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:58.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:54:0) after 1m0s
[06:12:58.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:54:0)
[06:12:58.792] Timer tick, asking Buildbucket for the build status
[06:12:59.197] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:59.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:55:0) after 1m0s
[06:13:59.195] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:55:0)
[06:13:59.195] Timer tick, asking Buildbucket for the build status
[06:13:59.372] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:59.373] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:56:0) after 1m0s
[06:14:59.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:56:0)
[06:14:59.395] Timer tick, asking Buildbucket for the build status
[06:14:59.466] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:59.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:57:0) after 1m0s
[06:15:59.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:57:0)
[06:15:59.521] Timer tick, asking Buildbucket for the build status
[06:15:59.864] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:59.864] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:58:0) after 1m0s
[06:16:59.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:58:0)
[06:16:59.889] Timer tick, asking Buildbucket for the build status
[06:17:00.228] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:00.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:59:0) after 1m0s
[06:18:00.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:59:0)
[06:18:00.292] Timer tick, asking Buildbucket for the build status
[06:18:00.361] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:00.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:60:0) after 1m0s
[06:19:00.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:60:0)
[06:19:00.344] Timer tick, asking Buildbucket for the build status
[06:19:00.420] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:00.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:61:0) after 1m0s
[06:20:00.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:61:0)
[06:20:00.461] Timer tick, asking Buildbucket for the build status
[06:20:00.600] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:00.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:62:0) after 1m0s
[06:21:00.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:62:0)
[06:21:00.700] Timer tick, asking Buildbucket for the build status
[06:21:00.998] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:00.999] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:63:0) after 1m0s
[06:22:01.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:63:0)
[06:22:01.012] Timer tick, asking Buildbucket for the build status
[06:22:01.082] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:01.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:64:0) after 1m0s
[06:23:01.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:64:0)
[06:23:01.105] Timer tick, asking Buildbucket for the build status
[06:23:01.502] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:01.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:65:0) after 1m0s
[06:24:01.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:65:0)
[06:24:01.551] Timer tick, asking Buildbucket for the build status
[06:24:01.935] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:01.935] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:66:0) after 1m0s
[06:25:01.973] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:66:0)
[06:25:01.973] Timer tick, asking Buildbucket for the build status
[06:25:02.290] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:02.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:67:0) after 1m0s
[06:26:02.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:67:0)
[06:26:02.409] Timer tick, asking Buildbucket for the build status
[06:26:02.708] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:02.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:68:0) after 1m0s
[06:27:02.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:68:0)
[06:27:02.730] Timer tick, asking Buildbucket for the build status
[06:27:02.794] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:02.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:69:0) after 1m0s
[06:28:02.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:69:0)
[06:28:02.786] Timer tick, asking Buildbucket for the build status
[06:28:02.840] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:02.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:70:0) after 1m0s
[06:29:02.861] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:70:0)
[06:29:02.861] Timer tick, asking Buildbucket for the build status
[06:29:02.954] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:02.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:71:0) after 1m0s
[06:30:02.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:71:0)
[06:30:02.975] Timer tick, asking Buildbucket for the build status
[06:30:03.249] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:03.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:72:0) after 1m0s
[06:31:03.271] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:72:0)
[06:31:03.271] Timer tick, asking Buildbucket for the build status
[06:31:03.639] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:03.639] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:73:0) after 1m0s
[06:32:03.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:73:0)
[06:32:03.664] Timer tick, asking Buildbucket for the build status
[06:32:03.734] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:03.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:74:0) after 1m0s
[06:33:03.754] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:74:0)
[06:33:03.754] Timer tick, asking Buildbucket for the build status
[06:33:03.829] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:03.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:75:0) after 1m0s
[06:34:03.855] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:75:0)
[06:34:03.855] Timer tick, asking Buildbucket for the build status
[06:34:03.940] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:03.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:76:0) after 1m0s
[06:35:03.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:76:0)
[06:35:03.981] Timer tick, asking Buildbucket for the build status
[06:35:04.070] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:04.070] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:77:0) after 1m0s
[06:36:04.093] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:77:0)
[06:36:04.093] Timer tick, asking Buildbucket for the build status
[06:36:04.387] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:04.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:78:0) after 1m0s
[06:37:04.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:78:0)
[06:37:04.406] Timer tick, asking Buildbucket for the build status
[06:37:04.468] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:04.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:79:0) after 1m0s
[06:38:04.489] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:79:0)
[06:38:04.489] Timer tick, asking Buildbucket for the build status
[06:38:04.543] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:04.543] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:80:0) after 1m0s
[06:39:04.565] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:80:0)
[06:39:04.565] Timer tick, asking Buildbucket for the build status
[06:39:04.617] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:04.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:81:0) after 1m0s
[06:40:04.688] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:81:0)
[06:40:04.688] Timer tick, asking Buildbucket for the build status
[06:40:04.782] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:04.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:82:0) after 1m0s
[06:41:05.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:82:0)
[06:41:05.008] Timer tick, asking Buildbucket for the build status
[06:41:05.108] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:05.108] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:83:0) after 1m0s
[06:42:05.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:83:0)
[06:42:05.169] Timer tick, asking Buildbucket for the build status
[06:42:05.251] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:05.251] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:84:0) after 1m0s
[06:43:05.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:84:0)
[06:43:05.463] Timer tick, asking Buildbucket for the build status
[06:43:05.542] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:05.542] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:85:0) after 1m0s
[06:44:05.652] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:85:0)
[06:44:05.652] Timer tick, asking Buildbucket for the build status
[06:44:05.723] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:05.723] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:86:0) after 1m0s
[06:45:05.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:86:0)
[06:45:05.807] Timer tick, asking Buildbucket for the build status
[06:45:05.949] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:05.949] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:87:0) after 1m0s
[06:46:06.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:87:0)
[06:46:06.003] Timer tick, asking Buildbucket for the build status
[06:46:06.132] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:06.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:88:0) after 1m0s
[06:47:06.206] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:88:0)
[06:47:06.206] Timer tick, asking Buildbucket for the build status
[06:47:06.268] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:06.268] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:89:0) after 1m0s
[06:48:06.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:89:0)
[06:48:06.381] Timer tick, asking Buildbucket for the build status
[06:48:06.597] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:06.597] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:90:0) after 1m0s
[06:49:06.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:90:0)
[06:49:06.709] Timer tick, asking Buildbucket for the build status
[06:49:06.776] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:06.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:91:0) after 1m0s
[06:50:06.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:91:0)
[06:50:06.823] Timer tick, asking Buildbucket for the build status
[06:50:07.099] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:07.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:92:0) after 1m0s
[06:51:07.178] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:92:0)
[06:51:07.178] Timer tick, asking Buildbucket for the build status
[06:51:07.273] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:07.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:93:0) after 1m0s
[06:52:07.363] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:93:0)
[06:52:07.363] Timer tick, asking Buildbucket for the build status
[06:52:07.426] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:07.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:94:0) after 1m0s
[06:53:07.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:94:0)
[06:53:07.417] Timer tick, asking Buildbucket for the build status
[06:53:07.699] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:07.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:95:0) after 1m0s
[06:54:07.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:95:0)
[06:54:07.782] Timer tick, asking Buildbucket for the build status
[06:54:07.896] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:07.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:96:0) after 1m0s
[06:55:07.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:96:0)
[06:55:07.909] Timer tick, asking Buildbucket for the build status
[06:55:08.202] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:08.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:97:0) after 1m0s
[06:56:08.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:97:0)
[06:56:08.257] Timer tick, asking Buildbucket for the build status
[06:56:08.375] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:08.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:98:0) after 1m0s
[06:57:08.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:98:0)
[06:57:08.357] Timer tick, asking Buildbucket for the build status
[06:57:08.789] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:08.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:99:0) after 1m0s
[06:58:08.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:99:0)
[06:58:08.809] Timer tick, asking Buildbucket for the build status
[06:58:09.073] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:09.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:100:0) after 1m0s
[06:59:09.222] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:100:0)
[06:59:09.222] Timer tick, asking Buildbucket for the build status
[06:59:09.393] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:09.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:101:0) after 1m0s
[07:00:09.467] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:101:0)
[07:00:09.467] Timer tick, asking Buildbucket for the build status
[07:00:09.522] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:09.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:102:0) after 1m0s
[07:01:09.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:102:0)
[07:01:09.686] Timer tick, asking Buildbucket for the build status
[07:01:09.802] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:09.802] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:103:0) after 1m0s
[07:02:09.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:103:0)
[07:02:09.868] Timer tick, asking Buildbucket for the build status
[07:02:09.971] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:09.971] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:104:0) after 1m0s
[07:03:10.018] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:104:0)
[07:03:10.018] Timer tick, asking Buildbucket for the build status
[07:03:10.096] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:10.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:105:0) after 1m0s
[07:04:10.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:105:0)
[07:04:10.116] Timer tick, asking Buildbucket for the build status
[07:04:10.231] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:10.231] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:106:0) after 1m0s
[07:05:10.295] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:106:0)
[07:05:10.295] Timer tick, asking Buildbucket for the build status
[07:05:10.373] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:10.373] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:107:0) after 1m0s
[07:06:10.476] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:107:0)
[07:06:10.476] Timer tick, asking Buildbucket for the build status
[07:06:10.565] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:10.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:108:0) after 1m0s
[07:07:10.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:108:0)
[07:07:10.644] Timer tick, asking Buildbucket for the build status
[07:07:10.724] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:10.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:109:0) after 1m0s
[07:08:10.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:109:0)
[07:08:10.732] Timer tick, asking Buildbucket for the build status
[07:08:10.787] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:10.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:110:0) after 1m0s
[07:09:10.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:110:0)
[07:09:10.807] Timer tick, asking Buildbucket for the build status
[07:09:10.915] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:10.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:111:0) after 1m0s
[07:10:10.962] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:111:0)
[07:10:10.962] Timer tick, asking Buildbucket for the build status
[07:10:11.053] Build 8859152048231621696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:11.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024582110286431696:112:0) after 1m0s
[07:10:40.038] Received PubSub notification, asking Buildbucket for the build status
[07:10:40.181] Build 8859152048231621696: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:10:40.181] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609657839291454",
"created_by": "project:chromium",
"created_ts": "1609651248671892",
"id": "8859152048231621696",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"caf24578f5ada7e553749e11351a7ae7af693929\"}}",
"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\": \"caf24578f5ada7e553749e11351a7ae7af693929\", \"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-87-cnen\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 179274, \"got_angle_revision\": \"bf02c31bec07a549cc8eea26ad0e63143954643d\", \"got_dawn_revision\": \"86980018b3f2786aeb5ded1220ec94bc927fa6b2\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"caf24578f5ada7e553749e11351a7ae7af693929\", \"got_revision_cp\": \"refs/heads/master@{#839966}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"ff29e249d3179766a40c9486183559fe3e5c1456\", \"got_v8_revision\": \"a3f2933bb6d06bd7473ccbed77714874e6bf63b3\", \"got_v8_revision_cp\": \"refs/heads/8.9.201@{#1}\", \"got_webrtc_revision\": \"2b87dd7c40c6f8bb4c6e962cd16fbee678e4b0c5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32899}\", \"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\": \"caf24578f5ada7e553749e11351a7ae7af693929\", \"swarm_hashes_refs/heads/master(at){#839966}_without_patch\": {\"absl_hardening_tests\": \"1a35ba3e911b4428c45c631e7369c64554793626\", \"accessibility_unittests\": \"8e77f1540e230b4fafd84b2dafe909b0b3cdf612\", \"angle_unittests\": \"a5a02357bf74b7873780532242237f39d19ef13b\", \"app_shell_unittests\": \"90238a3590128f8b8b65af710b8a44596572a96b\", \"aura_unittests\": \"60f2b653c9ad4d67bcaef7c9958e9ebc7d8be0da\", \"base_unittests\": \"95fca8369cf1464e2f2fbb9dfd2d0791b2d996ad\", \"base_util_unittests\": \"7eea630d59ae15c23c790a6e00d0413c4d09605c\", \"blink_common_unittests\": \"b448d37f2a3e8206a3111be821a3333760d72786\", \"blink_fuzzer_unittests\": \"f3c4e83045cbb98931895defb9fe1de1f919a935\", \"blink_heap_unittests\": \"d1c4ec563abd485ebc2f61e5eb9b2784e8f56490\", \"blink_platform_unittests\": \"cfdb96c3d9d76f90d211dcc002fcd246f8716022\", \"blink_python_tests\": \"d497d16bcbf24ac2a27598e828450ea6367236b0\", \"blink_unittests\": \"30168593e503af86efb2960aa0e17eac75539678\", \"blink_web_tests\": \"07cbf2764d2020bc36b7edacc4984faebaca5aa6\", \"boringssl_crypto_tests\": \"74b81218495c8b432eadf9c6e8535fae5a9ecca1\", \"boringssl_ssl_tests\": \"f4e422a5cae0a0b4f04a11dc6aae30fdd8cc37bf\", \"browser_tests\": \"2ac0fcb4a954c40105292e8b7b854012d2f946e4\", \"capture_unittests\": \"4a5c98c3811547c46473598a5668d135bec7f4bc\", \"cast_unittests\": \"54019ca7b5cc6c7942575a98cc37af24da82629f\", \"cc_unittests\": \"ccbe377bdfb0ed484e0fc9d260ec34c2d5b92d94\", \"chrome_app_unittests\": \"9e01c0d8037e3da7769ac994a3a8f3ef215cfa05\", \"chromedriver_unittests\": \"474f95245115e61117a5706144ba94ccad0b56d5\", \"components_browsertests\": \"98c9d6c40dc1a0ec298695e2592db638e419f63f\", \"components_unittests\": \"bc88f4b2e2f7d0456655822d08d4e79800e8edad\", \"compositor_unittests\": \"3e7a714afc3a93315fa6d8395243b5d7e6445e66\", \"content_browsertests\": \"7f7c92511a3bb29f624d503c5ce0896faef9946b\", \"content_shell_crash_test\": \"a865859b38269cad3e65d7b480d2f9e8b7f7b6fd\", \"content_unittests\": \"a8142a406bbb13323cd4852a49c57fa8968e3e29\", \"crashpad_tests\": \"25ad2cec13bf3180a619e09a1fef5197b82f97ab\", \"cronet_tests\": \"e73fb9de769ce56f73cb090dba0c0b654cf578f8\", \"cronet_unittests\": \"fdde87f26879580ce4008b1af00ddd239304cece\", \"crypto_unittests\": \"d7a7d65d32cee3c12e9076750fa0224421a24168\", \"dbus_unittests\": \"f658c6b5cf421732ce1757d2c00b57b501577298\", \"device_unittests\": \"32542933219287e809fab1d9d42f2dc3cd5c62ed\", \"display_unittests\": \"5a3bf820dc047df3636d7aa227ff94d3059a4c9e\", \"events_unittests\": \"794e9a0fa265ee8c605e1020d73d44d643cb857e\", \"extensions_browsertests\": \"ee68ff757b833752fa6d84535accc446344ed08b\", \"extensions_unittests\": \"7186527735e6822674f29d6c319fa4b24d907a42\", \"filesystem_service_unittests\": \"2d4e2329cd7143c8580c07a79ba0f57b0012c7b4\", \"flatbuffers_unittests\": \"d051d66da1ab229778a7e9a8f6ace686eaf5e782\", \"gcm_unit_tests\": \"87dde41f4327068a1c5acde1cdabeb902d8515ca\", \"gfx_unittests\": \"bf5c986f7be27ec5e403a5fb29214ea0cfae423b\", \"gin_unittests\": \"f7f4954fccd2ba33fcf4bc04fbf575b00b24b84c\", \"google_apis_unittests\": \"b6621751579373d78b7201ae9b1c9d968daecc3d\", \"gpu_unittests\": \"460cc6d87b3a5b45c75965635dfcecd29412660d\", \"grit_python_unittests\": \"275c161e38b800af0a18bf8ee2ae20e83dfa4ea2\", \"gwp_asan_unittests\": \"6791c52b151b2a58393ad4c4064a8ef0bb20ae3a\", \"headless_browsertests\": \"29e138b685ffca874e1e02452b14803f55adac65\", \"headless_unittests\": \"bc62ddc40b1bc91ee6e2c17f9b1510fe211ada5b\", \"interactive_ui_tests\": \"107e0cbf0eb88f93d67906ea4a3cd6b261d2085b\", \"ipc_tests\": \"2fd5b2219a39bfbc7160ecd9ab8308f5f1740dcd\", \"jingle_unittests\": \"316da1785ac717e08bfc042c04d330c4d7fb406f\", \"latency_unittests\": \"42e4a385c44d03b85aaf818c56502d9adcc4dfc5\", \"libjingle_xmpp_unittests\": \"212c0b1ad0ad4894970139cd604da6462615e8c2\", \"liburlpattern_unittests\": \"43cfc79e7fcef9cb105626e852e82b601362ad0e\", \"media_blink_unittests\": \"e61126eb8968ad153be982c4f1280b8f035d45ad\", \"media_unittests\": \"d4998d38b694776b53ae5ed478a625799c4926ff\", \"message_center_unittests\": \"319fe1b8284c59db2857a68918da92177e6edda1\", \"metrics_python_tests\": \"eb0718254148c9aeee3f0686c88850f5b11c344a\", \"midi_unittests\": \"ff37a4dea88d9ba802201d3296c4f2a47239b8f9\", \"mojo_core_unittests\": \"1e07ed8c9a6e78569ba80e9404f55c5f508ad3d7\", \"mojo_unittests\": \"0ce3de71baf0f8fdd4c958c01f13a9214fb9e92d\", \"nacl_helper_nonsfi_unittests\": \"0ad2e84479f03309391ddabc81364735db023444\", \"nacl_loader_unittests\": \"5edfe91607b556037518baa15f081d51d0d9ba16\", \"native_theme_unittests\": \"bb6d5ecebea7f84c1bf0c2f4752c1409a7b8d21e\", \"net_unittests\": \"a90445ff9977f99b0f089d035bd2ce7663790406\", \"openscreen_unittests\": \"b9e7c85bf1195f07b9c2f23eba459f79aa769744\", \"pdf_unittests\": \"5f2a19aec6750141ca78648504333c00c15bca54\", \"perfetto_unittests\": \"e976cbb693f2e4a1094eb233b9dd8c8758a3f141\", \"ppapi_unittests\": \"0fa818a0492358117ed11e2c928661eafebc1f45\", \"printing_unittests\": \"e97e3dde051be63afcb0d3fe699fca0346f8dff2\", \"remoting_unittests\": \"159cb6021fac7ceb913d718ea642ebbcbd8e75ee\", \"sandbox_linux_unittests\": \"c9449afc9bce0457b061d92f6104856018d4babc\", \"service_manager_unittests\": \"4ed06d37ee56a76f64a22e25836ee3030d8441ce\", \"services_unittests\": \"e2bfff447e3cf8e93ee5e8b0ddf93fd0a99841b4\", \"shell_dialogs_unittests\": \"614885b8eaac0c3eb16d77a01e12cd77ed6d90b0\", \"skia_unittests\": \"195394309f956226d389054c89a9a2880a8e3ac1\", \"snapshot_unittests\": \"53959fdc7cd3977301089ca343aa4ad3e158ee27\", \"sql_unittests\": \"235deb0c975ddc0097c1fae599181fe824acbbf6\", \"storage_unittests\": \"0c42394093c91ed9a600376e821f3cf3a3ff2c58\", \"sync_integration_tests\": \"99fe092c41a56d049a35a4285a269c35e2d353e2\", \"telemetry_gpu_unittests\": \"5e2b50beab9527fc37886cff1e9cf81ec95c39c5\", \"telemetry_perf_unittests\": \"8a590d5c1b8bcb6238dadf31f597adc6b5e0cd7a\", \"telemetry_unittests\": \"c22b783d9ed5a0f30b96f62b451fd9ca9c304a9f\", \"traffic_annotation_auditor_unittests\": \"65e3967be6d6b5db0ac699be0e77c190bc841ca3\", \"ui_base_unittests\": \"cbc627746e2e66e24866b1ac153d74f02fa8cd95\", \"ui_touch_selection_unittests\": \"470f5b1056f6cd659d8a31d80e7197f1c68a7fbd\", \"unit_tests\": \"0db415a8b4772fe46cd1b55713162eaafe0b70a2\", \"url_unittests\": \"dc864063e39dadd4d2541b1b6c0efd66437a8dc3\", \"views_perftests\": \"343dee1984b9a7c51e8b57c72fc60fb992411fdf\", \"views_unittests\": \"b343931dbe37d251a5ef8f1035da2fa7d5fb4629\", \"viz_unittests\": \"64e08faeb61f9dc30bf7a0f5b1329539cc5d834a\", \"vr_common_unittests\": \"fe4d3f9c5eb463bf428d5d8d65ea9fdd9f47f188\", \"vr_pixeltests\": \"71e6657697e78d7267989869220b56d3e14d86d2\", \"webdriver_wpt_tests\": \"0711811855813a620928b44de73cd2e52850b96b\", \"weblayer_browsertests\": \"e1dcaa3e5b5d8a7dc135fd8de28c3095782e512c\", \"weblayer_unittests\": \"863b0ef545c9ba575d1b30f4f7a8db3b78373f36\", \"wm_unittests\": \"3ec446da2e9af94eb7ac18dc6c65ed55f45eae3a\", \"wtf_unittests\": \"f7d0e035f9ad96f4f12b92cc54690d0a15cc4158\", \"x11_unittests\": \"2606b960498e9b9539e669277a5b152ea23f0df6\", \"xr_browser_tests\": \"e8bc3b7951b7b6b996638235b0308a7da1fa0052\", \"zlib_unittests\": \"7b6c59efd1f8b7f2c262fad85ca36dae52e34a49\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_06f1ed350fecda52f561db3eb00cb39e105b14f5c02d94078111c7babc8da8c6_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_dd987fcd94b516d81fcf1552cd73a9eed370c3dc02cc1a52ddee828f1ab8817d_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-87-cnen\"], \"image\": [\"chrome-xenial-20122000-38c59757d9b\"], \"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": "1609653330351316",
"status": "COMPLETED",
"status_changed_ts": "1609657839690848",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179274",
"builder:Linux Builder (dbg)",
"buildset:commit/git/caf24578f5ada7e553749e11351a7ae7af693929",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/caf24578f5ada7e553749e11351a7ae7af693929",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024582110286431696",
"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/8859152048231621696/+/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:50df8269c7afb110",
"user_agent:luci-scheduler"
],
"updated_ts": "1609657839700635",
"url": "https://ci.chromium.org/b/8859152048231621696",
"utcnow_ts": "1609657840147443"
}
}
[07:10:40.181] Invocation finished in 1h49m52.852800632s with status SUCCEEDED