[15:50:04.275] New invocation is queued and will start shortly
[15:50:05.420] Starting the invocation (attempt 1)
[15:50:05.479] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:50:05.479] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:50:05.480] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025901473772907824",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6abe4e6420a1d52f6c3fe3b2bd77fa2530c48c03\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9025901473772907824",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/6abe4e6420a1d52f6c3fe3b2bd77fa2530c48c03",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6abe4e6420a1d52f6c3fe3b2bd77fa2530c48c03",
"gitiles_ref:refs/heads/master"
]
}
[15:50:06.590] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608393005623126",
"id": "8860471411693590896",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6abe4e6420a1d52f6c3fe3b2bd77fa2530c48c03\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608393006406150",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178828",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6abe4e6420a1d52f6c3fe3b2bd77fa2530c48c03",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6abe4e6420a1d52f6c3fe3b2bd77fa2530c48c03",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025901473772907824",
"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/8860471411693590896/+/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": "1608393006406254",
"url": "https://ci.chromium.org/b/8860471411693590896",
"utcnow_ts": "1608393006568780"
}
}
[15:50:06.590] Task URL: https://ci.chromium.org/b/8860471411693590896
[15:50:06.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:2:0) after 1m0s
[15:51:07.156] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:2:0)
[15:51:07.156] Timer tick, asking Buildbucket for the build status
[15:51:07.252] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:51:07.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:3:0) after 1m0s
[15:52:07.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:3:0)
[15:52:07.434] Timer tick, asking Buildbucket for the build status
[15:52:07.495] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:52:07.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:4:0) after 1m0s
[15:53:07.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:4:0)
[15:53:07.538] Timer tick, asking Buildbucket for the build status
[15:53:07.648] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:53:07.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:5:0) after 1m0s
[15:54:07.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:5:0)
[15:54:07.821] Timer tick, asking Buildbucket for the build status
[15:54:08.298] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:54:08.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:6:0) after 1m0s
[15:55:08.408] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:6:0)
[15:55:08.408] Timer tick, asking Buildbucket for the build status
[15:55:08.580] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:55:08.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:7:0) after 1m0s
[15:56:08.670] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:7:0)
[15:56:08.670] Timer tick, asking Buildbucket for the build status
[15:56:08.751] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:56:08.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:8:0) after 1m0s
[15:57:08.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:8:0)
[15:57:08.873] Timer tick, asking Buildbucket for the build status
[15:57:08.956] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:57:08.956] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:9:0) after 1m0s
[15:58:09.126] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:9:0)
[15:58:09.126] Timer tick, asking Buildbucket for the build status
[15:58:09.184] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:58:09.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:10:0) after 1m0s
[15:59:09.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:10:0)
[15:59:09.205] Timer tick, asking Buildbucket for the build status
[15:59:09.384] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:59:09.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:11:0) after 1m0s
[16:00:09.412] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:11:0)
[16:00:09.412] Timer tick, asking Buildbucket for the build status
[16:00:09.697] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:00:09.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:12:0) after 1m0s
[16:01:09.811] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:12:0)
[16:01:09.811] Timer tick, asking Buildbucket for the build status
[16:01:09.886] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:01:09.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:13:0) after 1m0s
[16:02:09.914] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:13:0)
[16:02:09.914] Timer tick, asking Buildbucket for the build status
[16:02:10.297] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:02:10.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:14:0) after 1m0s
[16:03:10.343] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:14:0)
[16:03:10.343] Timer tick, asking Buildbucket for the build status
[16:03:10.435] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:03:10.435] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:15:0) after 1m0s
[16:04:10.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:15:0)
[16:04:10.460] Timer tick, asking Buildbucket for the build status
[16:04:11.921] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:04:11.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:16:0) after 1m0s
[16:05:11.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:16:0)
[16:05:11.921] Timer tick, asking Buildbucket for the build status
[16:05:12.307] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:05:12.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:17:0) after 1m0s
[16:06:12.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:17:0)
[16:06:12.334] Timer tick, asking Buildbucket for the build status
[16:06:12.409] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:06:12.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:18:0) after 1m0s
[16:07:12.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:18:0)
[16:07:12.428] Timer tick, asking Buildbucket for the build status
[16:07:12.517] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:07:12.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:19:0) after 1m0s
[16:08:12.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:19:0)
[16:08:12.545] Timer tick, asking Buildbucket for the build status
[16:08:12.614] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:08:12.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:20:0) after 1m0s
[16:09:12.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:20:0)
[16:09:12.641] Timer tick, asking Buildbucket for the build status
[16:09:12.707] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:09:12.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:21:0) after 1m0s
[16:10:12.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:21:0)
[16:10:12.786] Timer tick, asking Buildbucket for the build status
[16:10:13.135] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:10:13.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:22:0) after 1m0s
[16:11:13.161] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:22:0)
[16:11:13.161] Timer tick, asking Buildbucket for the build status
[16:11:13.222] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:11:13.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:23:0) after 1m0s
[16:12:13.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:23:0)
[16:12:13.247] Timer tick, asking Buildbucket for the build status
[16:12:13.559] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:12:13.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:24:0) after 1m0s
[16:13:13.583] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:24:0)
[16:13:13.583] Timer tick, asking Buildbucket for the build status
[16:13:13.660] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:13:13.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:25:0) after 1m0s
[16:14:13.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:25:0)
[16:14:13.682] Timer tick, asking Buildbucket for the build status
[16:14:13.907] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:14:13.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:26:0) after 1m0s
[16:15:13.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:26:0)
[16:15:13.931] Timer tick, asking Buildbucket for the build status
[16:15:14.107] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:15:14.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:27:0) after 1m0s
[16:16:14.141] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:27:0)
[16:16:14.141] Timer tick, asking Buildbucket for the build status
[16:16:14.213] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:16:14.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:28:0) after 1m0s
[16:17:14.237] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:28:0)
[16:17:14.237] Timer tick, asking Buildbucket for the build status
[16:17:14.297] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:17:14.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:29:0) after 1m0s
[16:18:14.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:29:0)
[16:18:14.287] Timer tick, asking Buildbucket for the build status
[16:18:14.362] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:18:14.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:30:0) after 1m0s
[16:19:14.392] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:30:0)
[16:19:14.392] Timer tick, asking Buildbucket for the build status
[16:19:14.452] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:19:14.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:31:0) after 1m0s
[16:20:14.443] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:31:0)
[16:20:14.443] Timer tick, asking Buildbucket for the build status
[16:20:14.541] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:20:14.541] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:32:0) after 1m0s
[16:21:14.625] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:32:0)
[16:21:14.625] Timer tick, asking Buildbucket for the build status
[16:21:14.735] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:21:14.735] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:33:0) after 1m0s
[16:22:14.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:33:0)
[16:22:14.793] Timer tick, asking Buildbucket for the build status
[16:22:14.996] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:22:14.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:34:0) after 1m0s
[16:23:15.123] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:34:0)
[16:23:15.123] Timer tick, asking Buildbucket for the build status
[16:23:15.212] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:23:15.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:35:0) after 1m0s
[16:24:15.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:35:0)
[16:24:15.231] Timer tick, asking Buildbucket for the build status
[16:24:15.326] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:24:15.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:36:0) after 1m0s
[16:25:15.397] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:36:0)
[16:25:15.397] Timer tick, asking Buildbucket for the build status
[16:25:15.898] Build 8860471411693590896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:25:15.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:37:0) after 1m0s
[16:25:43.342] Received PubSub notification, asking Buildbucket for the build status
[16:25:43.658] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:16.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:37:0)
[16:26:16.071] Timer tick, asking Buildbucket for the build status
[16:26:16.192] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:16.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:39:0) after 1m0s
[16:27:16.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:39:0)
[16:27:16.262] Timer tick, asking Buildbucket for the build status
[16:27:16.400] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:16.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:40:0) after 1m0s
[16:28:16.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:40:0)
[16:28:16.428] Timer tick, asking Buildbucket for the build status
[16:28:16.493] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:16.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:41:0) after 1m0s
[16:29:16.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:41:0)
[16:29:16.529] Timer tick, asking Buildbucket for the build status
[16:29:16.608] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:16.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:42:0) after 1m0s
[16:30:16.646] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:42:0)
[16:30:16.646] Timer tick, asking Buildbucket for the build status
[16:30:16.815] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:16.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:43:0) after 1m0s
[16:31:16.880] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:43:0)
[16:31:16.880] Timer tick, asking Buildbucket for the build status
[16:31:17.006] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:17.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:44:0) after 1m0s
[16:32:17.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:44:0)
[16:32:17.028] Timer tick, asking Buildbucket for the build status
[16:32:17.108] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:17.108] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:45:0) after 1m0s
[16:33:17.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:45:0)
[16:33:17.127] Timer tick, asking Buildbucket for the build status
[16:33:17.177] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:17.177] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:46:0) after 1m0s
[16:34:17.196] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:46:0)
[16:34:17.196] Timer tick, asking Buildbucket for the build status
[16:34:17.248] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:17.248] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:47:0) after 1m0s
[16:35:17.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:47:0)
[16:35:17.269] Timer tick, asking Buildbucket for the build status
[16:35:17.358] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:17.358] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:48:0) after 1m0s
[16:36:17.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:48:0)
[16:36:17.379] Timer tick, asking Buildbucket for the build status
[16:36:17.617] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:17.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:49:0) after 1m0s
[16:37:17.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:49:0)
[16:37:17.664] Timer tick, asking Buildbucket for the build status
[16:37:17.719] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:17.719] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:50:0) after 1m0s
[16:38:17.794] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:50:0)
[16:38:17.794] Timer tick, asking Buildbucket for the build status
[16:38:17.904] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:17.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:51:0) after 1m0s
[16:39:17.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:51:0)
[16:39:17.930] Timer tick, asking Buildbucket for the build status
[16:39:17.982] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:17.982] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:52:0) after 1m0s
[16:40:18.044] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:52:0)
[16:40:18.044] Timer tick, asking Buildbucket for the build status
[16:40:18.146] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:18.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:53:0) after 1m0s
[16:41:18.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:53:0)
[16:41:18.334] Timer tick, asking Buildbucket for the build status
[16:41:18.400] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:18.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:54:0) after 1m0s
[16:42:18.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:54:0)
[16:42:18.441] Timer tick, asking Buildbucket for the build status
[16:42:18.528] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:18.529] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:55:0) after 1m0s
[16:43:18.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:55:0)
[16:43:18.535] Timer tick, asking Buildbucket for the build status
[16:43:18.646] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:18.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:56:0) after 1m0s
[16:44:18.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:56:0)
[16:44:18.693] Timer tick, asking Buildbucket for the build status
[16:44:18.744] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:18.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:57:0) after 1m0s
[16:45:18.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:57:0)
[16:45:18.826] Timer tick, asking Buildbucket for the build status
[16:45:19.101] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:19.101] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:58:0) after 1m0s
[16:46:19.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:58:0)
[16:46:19.189] Timer tick, asking Buildbucket for the build status
[16:46:19.257] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:19.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:59:0) after 1m0s
[16:47:19.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:59:0)
[16:47:19.344] Timer tick, asking Buildbucket for the build status
[16:47:19.506] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:19.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:60:0) after 1m0s
[16:48:19.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:60:0)
[16:48:19.593] Timer tick, asking Buildbucket for the build status
[16:48:19.818] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:19.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:61:0) after 1m0s
[16:49:19.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:61:0)
[16:49:19.822] Timer tick, asking Buildbucket for the build status
[16:49:19.880] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:19.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:62:0) after 1m0s
[16:50:19.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:62:0)
[16:50:19.913] Timer tick, asking Buildbucket for the build status
[16:50:20.372] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:20.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:63:0) after 1m0s
[16:51:20.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:63:0)
[16:51:20.446] Timer tick, asking Buildbucket for the build status
[16:51:20.690] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:20.690] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:64:0) after 1m0s
[16:52:20.791] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:64:0)
[16:52:20.791] Timer tick, asking Buildbucket for the build status
[16:52:20.926] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:20.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:65:0) after 1m0s
[16:53:20.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:65:0)
[16:53:20.992] Timer tick, asking Buildbucket for the build status
[16:53:21.061] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:21.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:66:0) after 1m0s
[16:54:21.086] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:66:0)
[16:54:21.086] Timer tick, asking Buildbucket for the build status
[16:54:21.192] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:21.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:67:0) after 1m0s
[16:55:21.264] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:67:0)
[16:55:21.264] Timer tick, asking Buildbucket for the build status
[16:55:21.351] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:21.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:68:0) after 1m0s
[16:56:21.376] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:68:0)
[16:56:21.376] Timer tick, asking Buildbucket for the build status
[16:56:21.433] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:21.433] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:69:0) after 1m0s
[16:57:21.453] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:69:0)
[16:57:21.453] Timer tick, asking Buildbucket for the build status
[16:57:21.513] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:21.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:70:0) after 1m0s
[16:58:21.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:70:0)
[16:58:21.545] Timer tick, asking Buildbucket for the build status
[16:58:21.609] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:21.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:71:0) after 1m0s
[16:59:21.907] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:71:0)
[16:59:21.907] Timer tick, asking Buildbucket for the build status
[16:59:22.038] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:22.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:72:0) after 1m0s
[17:00:22.274] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:72:0)
[17:00:22.274] Timer tick, asking Buildbucket for the build status
[17:00:22.591] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:22.591] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:73:0) after 1m0s
[17:01:23.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:73:0)
[17:01:23.209] Timer tick, asking Buildbucket for the build status
[17:01:23.327] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:23.327] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:74:0) after 1m0s
[17:02:23.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:74:0)
[17:02:23.350] Timer tick, asking Buildbucket for the build status
[17:02:23.695] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:23.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:75:0) after 1m0s
[17:03:23.755] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:75:0)
[17:03:23.755] Timer tick, asking Buildbucket for the build status
[17:03:23.814] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:23.814] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:76:0) after 1m0s
[17:04:23.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:76:0)
[17:04:23.793] Timer tick, asking Buildbucket for the build status
[17:04:23.858] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:23.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:77:0) after 1m0s
[17:05:23.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:77:0)
[17:05:23.909] Timer tick, asking Buildbucket for the build status
[17:05:24.428] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:24.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:78:0) after 1m0s
[17:06:24.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:78:0)
[17:06:24.459] Timer tick, asking Buildbucket for the build status
[17:06:24.519] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:24.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:79:0) after 1m0s
[17:07:24.543] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:79:0)
[17:07:24.543] Timer tick, asking Buildbucket for the build status
[17:07:24.774] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:24.774] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:80:0) after 1m0s
[17:08:24.770] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:80:0)
[17:08:24.770] Timer tick, asking Buildbucket for the build status
[17:08:24.885] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:24.885] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:81:0) after 1m0s
[17:09:24.940] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:81:0)
[17:09:24.940] Timer tick, asking Buildbucket for the build status
[17:09:25.090] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:25.090] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:82:0) after 1m0s
[17:10:25.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:82:0)
[17:10:25.149] Timer tick, asking Buildbucket for the build status
[17:10:25.262] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:25.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:83:0) after 1m0s
[17:11:25.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:83:0)
[17:11:25.386] Timer tick, asking Buildbucket for the build status
[17:11:25.441] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:25.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:84:0) after 1m0s
[17:12:25.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:84:0)
[17:12:25.473] Timer tick, asking Buildbucket for the build status
[17:12:25.625] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:25.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:85:0) after 1m0s
[17:13:25.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:85:0)
[17:13:25.677] Timer tick, asking Buildbucket for the build status
[17:13:25.812] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:25.812] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:86:0) after 1m0s
[17:14:25.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:86:0)
[17:14:25.845] Timer tick, asking Buildbucket for the build status
[17:14:26.388] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:26.388] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:87:0) after 1m0s
[17:15:26.416] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:87:0)
[17:15:26.416] Timer tick, asking Buildbucket for the build status
[17:15:26.549] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:26.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:88:0) after 1m0s
[17:16:26.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:88:0)
[17:16:26.609] Timer tick, asking Buildbucket for the build status
[17:16:26.690] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:26.690] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:89:0) after 1m0s
[17:17:26.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:89:0)
[17:17:26.744] Timer tick, asking Buildbucket for the build status
[17:17:26.798] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:26.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:90:0) after 1m0s
[17:18:26.820] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:90:0)
[17:18:26.820] Timer tick, asking Buildbucket for the build status
[17:18:26.868] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:26.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:91:0) after 1m0s
[17:19:26.914] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:91:0)
[17:19:26.914] Timer tick, asking Buildbucket for the build status
[17:19:27.013] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:27.013] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:92:0) after 1m0s
[17:20:27.037] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:92:0)
[17:20:27.037] Timer tick, asking Buildbucket for the build status
[17:20:27.144] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:27.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:93:0) after 1m0s
[17:21:27.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:93:0)
[17:21:27.173] Timer tick, asking Buildbucket for the build status
[17:21:27.327] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:27.327] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:94:0) after 1m0s
[17:22:27.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:94:0)
[17:22:27.357] Timer tick, asking Buildbucket for the build status
[17:22:27.500] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:27.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:95:0) after 1m0s
[17:23:27.525] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:95:0)
[17:23:27.525] Timer tick, asking Buildbucket for the build status
[17:23:27.599] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:27.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:96:0) after 1m0s
[17:24:27.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:96:0)
[17:24:27.620] Timer tick, asking Buildbucket for the build status
[17:24:27.794] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:27.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:97:0) after 1m0s
[17:25:27.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:97:0)
[17:25:27.823] Timer tick, asking Buildbucket for the build status
[17:25:27.941] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:27.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:98:0) after 1m0s
[17:26:27.972] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:98:0)
[17:26:27.972] Timer tick, asking Buildbucket for the build status
[17:26:28.414] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:28.414] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:99:0) after 1m0s
[17:27:28.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:99:0)
[17:27:28.465] Timer tick, asking Buildbucket for the build status
[17:27:28.547] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:28.547] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:100:0) after 1m0s
[17:28:28.537] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:100:0)
[17:28:28.537] Timer tick, asking Buildbucket for the build status
[17:28:28.766] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:28.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:101:0) after 1m0s
[17:29:28.830] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:101:0)
[17:29:28.830] Timer tick, asking Buildbucket for the build status
[17:29:28.887] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:28.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:102:0) after 1m0s
[17:30:28.949] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:102:0)
[17:30:28.949] Timer tick, asking Buildbucket for the build status
[17:30:29.036] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:29.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:103:0) after 1m0s
[17:31:29.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:103:0)
[17:31:29.095] Timer tick, asking Buildbucket for the build status
[17:31:29.156] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:29.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:104:0) after 1m0s
[17:32:29.160] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:104:0)
[17:32:29.160] Timer tick, asking Buildbucket for the build status
[17:32:29.272] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:29.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:105:0) after 1m0s
[17:33:29.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:105:0)
[17:33:29.267] Timer tick, asking Buildbucket for the build status
[17:33:29.364] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:29.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:106:0) after 1m0s
[17:34:29.390] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:106:0)
[17:34:29.390] Timer tick, asking Buildbucket for the build status
[17:34:29.592] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:29.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:107:0) after 1m0s
[17:35:29.584] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:107:0)
[17:35:29.584] Timer tick, asking Buildbucket for the build status
[17:35:30.631] Build 8860471411693590896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:30.631] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025901473772907824:108:0) after 1m0s
[17:36:07.984] Received PubSub notification, asking Buildbucket for the build status
[17:36:08.077] Build 8860471411693590896: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:36:08.077] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608399367482540",
"created_by": "project:chromium",
"created_ts": "1608393005623126",
"id": "8860471411693590896",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6abe4e6420a1d52f6c3fe3b2bd77fa2530c48c03\"}}",
"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\": \"6abe4e6420a1d52f6c3fe3b2bd77fa2530c48c03\", \"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-19-pbb4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178828, \"got_angle_revision\": \"0322fc1a67c4458a00169ce2bf45fcaf3b5f297a\", \"got_dawn_revision\": \"5d4fd88a7403aa255d49919d011af54c691b344a\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"6abe4e6420a1d52f6c3fe3b2bd77fa2530c48c03\", \"got_revision_cp\": \"refs/heads/master@{#838523}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"c4b600873d9668aeeb4f28e20f86d82b5c75379c\", \"got_v8_revision_cp\": \"refs/heads/8.9.177@{#1}\", \"got_webrtc_revision\": \"d7f750f7be4b2f61018d3cb55a995d09daa226e6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32862}\", \"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\": \"6abe4e6420a1d52f6c3fe3b2bd77fa2530c48c03\", \"swarm_hashes_refs/heads/master(at){#838523}_without_patch\": {\"absl_hardening_tests\": \"8f375d384e5b8a2ebdecc24bca0624147a11a2f1\", \"accessibility_unittests\": \"cc8e83d683c997dce1ebab91a8821407db8b133a\", \"angle_unittests\": \"17de1ab780df9e33a75d55ad69561d9fe9b69c41\", \"app_shell_unittests\": \"04955cfd9fd1103c2164c069159f42f202f84ce6\", \"aura_unittests\": \"a7035a7a3a55c0121502fd54a33c713d1819ea5e\", \"base_unittests\": \"d707ed28b15b976451dca9fc89e14bff4ab070bc\", \"base_util_unittests\": \"84b03bad7f08af7e4c9c18e185422390f121e9d4\", \"blink_common_unittests\": \"a0dff7610f87368bf07100a4b653fd119c38cc57\", \"blink_fuzzer_unittests\": \"b4f75a39e20f0fe40278bdafceeebb9f67a5602d\", \"blink_heap_unittests\": \"82e73dbd85ae811c12aebe7f72ff47dafa3d7616\", \"blink_platform_unittests\": \"e63a47d39d31b57a3e9af9ca89400b2c18f8b382\", \"blink_python_tests\": \"a850068bffdc4a670df6ad15aeda052beec9a023\", \"blink_unittests\": \"27d6c838d50ef3d077c2072623e796280aab1035\", \"blink_web_tests\": \"e9f1a3ea8ae43853cbb289ca87097e3da3ec2d94\", \"boringssl_crypto_tests\": \"339c2652771d7b3e164a30240cc807aad06fc5f2\", \"boringssl_ssl_tests\": \"4125b55d8cb2aefef23667153037cfe9fe874c0e\", \"browser_tests\": \"ef0d1f8c3abb0278379eecd73d1c87047013eebc\", \"capture_unittests\": \"fe2cf6e304be404b8a522a7d77717a11928af338\", \"cast_unittests\": \"1c96c62285551cf0b7b4f75e962623be93828c61\", \"cc_unittests\": \"f76e40216ba16aeadd5bffc002b19bb0f0687b95\", \"chrome_app_unittests\": \"86ab8ffcc3967081bce39735fab074f627b9af78\", \"chromedriver_unittests\": \"e48a25b24901c1a543e84c7b954baf151103467d\", \"components_browsertests\": \"269b6d1cc568c6118cd35fb49fcf36d6b3478014\", \"components_unittests\": \"13a6dd71492ec02d9ab1fabcfc328950cb7e36fc\", \"compositor_unittests\": \"2eb96d22b05c76fecac60e302d09c09a3607d2fc\", \"content_browsertests\": \"5d086640a703ecb925c3cfc804a64a57fbe54987\", \"content_shell_crash_test\": \"9e76c191f92e5d060958708b5fb70f994c647ae3\", \"content_unittests\": \"b1b5b4755e3761d8562ea9fda995b8bad74280eb\", \"crashpad_tests\": \"49f3237b435657bd0a41708c953bbb6e2282e049\", \"cronet_tests\": \"b3083194d91cd5974dbe4e5a061d21a307589f97\", \"cronet_unittests\": \"4a06513acb5948251e6c6389f9c8475572522816\", \"crypto_unittests\": \"b4ea65d67dbc4046191211f280ea3161f64e3024\", \"dbus_unittests\": \"97b1705f3871e03b4dd6c1be2b4fd003b75ee19e\", \"device_unittests\": \"499123c936360e0ca267e0d35f876731fd53f850\", \"display_unittests\": \"1c1488fcfa9585b82ac28da69227dda2355b6d2e\", \"events_unittests\": \"2321cbc9875dbb152398313c19233643beb3d4a4\", \"extension_docserver_python_unittests\": \"d2c9142966a0b67f7aec9c3117242150c75cd902\", \"extensions_browsertests\": \"d9ed03cbda9a0a4ef79df6edac63d0464a4cf245\", \"extensions_unittests\": \"61d8c5142ab4d991ed72bc4aafd992516b54ec32\", \"filesystem_service_unittests\": \"0b40852fd3775977720bbc5f6e20cd46754b1bb3\", \"flatbuffers_unittests\": \"d051d66da1ab229778a7e9a8f6ace686eaf5e782\", \"gcm_unit_tests\": \"f0d0767d92bc9e9cba567b7f078ed42e37d1e269\", \"gfx_unittests\": \"d80a33fcc75e2896c72da7413bc49df4d33995b3\", \"gin_unittests\": \"af3512bbbcf68aeee7ce52b52d627d4d6dacfe23\", \"google_apis_unittests\": \"b297688d2acc895a454e55d5aefc9d8b1492c55a\", \"gpu_unittests\": \"d2c3f955ea777b5cd70e903995b19ede2d9951a6\", \"grit_python_unittests\": \"275c161e38b800af0a18bf8ee2ae20e83dfa4ea2\", \"gwp_asan_unittests\": \"85a4409656e25530c6e025787387b24b69465007\", \"headless_browsertests\": \"1d71b969027fb8acde368bcb305585e3d74886df\", \"headless_unittests\": \"00ebc3828eb4791afca12c42cb4474940df27437\", \"interactive_ui_tests\": \"d1403a76354fe14eaffa7b40af4619ca57603892\", \"ipc_tests\": \"2b1624151520172c529bfbe9fb113c1d5013ff29\", \"jingle_unittests\": \"00ea73e21ffc129de2407e9e79dd0f562a648c97\", \"latency_unittests\": \"1f6b809923b319be1fb8e042ad9330f1ee73733b\", \"libjingle_xmpp_unittests\": \"ee7c00a4b74ab5c1ce3f1a562ade3985b8ed5b64\", \"liburlpattern_unittests\": \"2474b765488b21a51c6bda6602ca1fc506c1de64\", \"media_blink_unittests\": \"c241d4447f5d2cbe69796078c127f9ca21f0bbb7\", \"media_unittests\": \"020003a5c27652f0f7e75ee61650743513d0172d\", \"message_center_unittests\": \"e1846b6beba88a9fee9f967ffb035f8a35248338\", \"metrics_python_tests\": \"9a057f240d8e448aea1f99ca8cd2be4817085334\", \"midi_unittests\": \"57a890852d18c64577e69240879eddae32ad007f\", \"mojo_core_unittests\": \"abb7d61cbf24e8c91d09191c5de588526a852443\", \"mojo_unittests\": \"638736ead48eab423e3bc06c9b836b7268657928\", \"nacl_helper_nonsfi_unittests\": \"504b27c5496dae8f718aa86efc3942da9cd9266e\", \"nacl_loader_unittests\": \"dd5e0e59a4556860eab6d73f43c35dd87ef53040\", \"native_theme_unittests\": \"095c58f890dd164668aec7880c983a4f0a310d28\", \"net_unittests\": \"ed63b978e2b48113613bbefe2bcd473d2b071a8e\", \"openscreen_unittests\": \"2d1f57d8eaca6a44913763b0f01449969bc47ece\", \"pdf_unittests\": \"8855012e4e13903d2db9ae7fcf0bafeb2d208ed6\", \"perfetto_unittests\": \"2b4794f2711a3c606bb1b5db4b17b4c5bc51e90d\", \"ppapi_unittests\": \"74da26a0d36172815d3a6d692d6eedf8884d8957\", \"printing_unittests\": \"f580371c35083a7ac57a9345e30edfc8f936ea4a\", \"remoting_unittests\": \"90e5ec5984b647bf2d0e446dc83b1a82f0b0459f\", \"sandbox_linux_unittests\": \"7b6c06a037257977d5ce0d7d5edadaef9eb97a47\", \"service_manager_unittests\": \"bf338b4006bffdca8e3ed213a48673ffaa0bc226\", \"services_unittests\": \"318df8bc51c6836d60cd0a259374fbb03a866167\", \"shell_dialogs_unittests\": \"29d1e9a3db969ac4774c0d2899e7d391f5afb06b\", \"skia_unittests\": \"8a160b4b94a76a09827149d11673f1ee5bf9e7a1\", \"snapshot_unittests\": \"9f7935a2c9dafd39b3ded8b562daf34977ec736a\", \"sql_unittests\": \"29d5e2732b97881338fedde8246ed0f24f84b4b7\", \"storage_unittests\": \"1023abec45c5ed9d0f8f9e7fab44fe455d88999d\", \"sync_integration_tests\": \"85b2f3c362c05d13b3599f240f45cd927d0ca8a5\", \"telemetry_gpu_unittests\": \"72e49f1d6f8f2162e1e79a624e9ce46fee20ad43\", \"telemetry_perf_unittests\": \"8d42ccdce0faf3417c0e20bffdb92b1f2ab857a4\", \"telemetry_unittests\": \"bf396d1cf924a8d30e8b635e77f40d48a0b06da1\", \"traffic_annotation_auditor_unittests\": \"5fc96914b84f2ff7bb978b419faf57a1a1405c1b\", \"ui_base_unittests\": \"796704614783f77b6c1b8d45792164a1f83396c2\", \"ui_touch_selection_unittests\": \"5181a9824f5d163b70c6d20f0103cd4e371a41ff\", \"unit_tests\": \"aa0002c28c435637c5af7d5a34430eacea29e77f\", \"url_unittests\": \"5b822a9d7fbf590f3099afe3a26445eb7a924efb\", \"views_perftests\": \"07d254d6c78c71d4b4b1c6f293c9ad87ef634532\", \"views_unittests\": \"86149741ed9c97107a5d68bac13c8e2972e30530\", \"viz_unittests\": \"3a1ff47b7426533fbb1d8a51c0dfd0822cca9d1c\", \"vr_common_unittests\": \"d18efd894a4772825a66f64e54716926cdbc29b8\", \"vr_pixeltests\": \"6c41d71ecd10e8cc15bec831c04215e8683fefca\", \"webdriver_wpt_tests\": \"a82a29317c918537552db8ca4e23b6643dab99eb\", \"weblayer_browsertests\": \"7657db9970f0d6c49c456497f1582fd05169eb6b\", \"weblayer_unittests\": \"9f736ef87d5db070aabf63adb27585cb6c0caa69\", \"wm_unittests\": \"63eaac043b0a9272febd9ed689e33a7931e36351\", \"wtf_unittests\": \"296ad9db0929820f9e3b295d7ae481947777bb26\", \"x11_unittests\": \"66680cbb5846464724070a4fc78f702eb7f9e0bf\", \"xr_browser_tests\": \"a4bbd69da102611d92328dda506d47fe8e8fa01b\", \"zlib_unittests\": \"d7b4949fd0c0340e972b0ab41b48f91449fbaa72\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_28be8b4e850be8bd7a9db0671ff876681ccdf0c2c048860e172c20e0c8b9b79b_v2\", \"builder_32ded518776cda8cac391977d607693e2958c39df4b87a6f7ec8056ca6add5b1_v2\", \"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_a15c792d02d243f2865d956ab51326d361a8fcfed3c44b30d209df7676d4718c_v2\", \"builder_a7b9f8880f1f76f2cce14c79e9b35da9a713af6654c6d1393cfbcc356d1ede5d_v2\", \"builder_c5a4a77f7d90ed750e2e3c196231723a8f9435afca7311d8fa2536a9dada12e3_v2\", \"builder_d1ade7eeaf5d4bfec46cdcc4260ff7266c5ca5ac9f935f1643683e9e2b66e303_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_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-19-pbb4\"], \"image\": [\"chrome-xenial-20121300-d43316a0aad\"], \"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": "1608395142506714",
"status": "COMPLETED",
"status_changed_ts": "1608399367763453",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178828",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6abe4e6420a1d52f6c3fe3b2bd77fa2530c48c03",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6abe4e6420a1d52f6c3fe3b2bd77fa2530c48c03",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025901473772907824",
"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/8860471411693590896/+/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:509483284f042c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1608399367768821",
"url": "https://ci.chromium.org/b/8860471411693590896",
"utcnow_ts": "1608399368064797"
}
}
[17:36:08.078] Invocation finished in 1h46m3.820773145s with status SUCCEEDED