[22:41:20.178] New invocation is queued and will start shortly
[22:41:21.293] Starting the invocation (attempt 1)
[22:41:21.363] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:41:21.363] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:41:21.363] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9056678567788632624",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d37592146efbad662b4f263e488799eff8858370\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9056678567788632624",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/d37592146efbad662b4f263e488799eff8858370",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d37592146efbad662b4f263e488799eff8858370",
"gitiles_ref:refs/heads/master"
]
}
[22:41:22.196] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1579041681584842",
"id": "8891248505649351936",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d37592146efbad662b4f263e488799eff8858370\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1579041682023215",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167378",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d37592146efbad662b4f263e488799eff8858370",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d37592146efbad662b4f263e488799eff8858370",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056678567788632624",
"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/8891248505649351936/+/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": "1579041682023351",
"url": "https://ci.chromium.org/b/8891248505649351936",
"utcnow_ts": "1579041682180498"
}
}
[22:41:22.196] Task URL: https://ci.chromium.org/b/8891248505649351936
[22:41:22.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:2:0) after 1m0s
[22:41:55.742] Received PubSub notification, asking Buildbucket for the build status
[22:41:55.946] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:22.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:2:0)
[22:42:22.262] Timer tick, asking Buildbucket for the build status
[22:42:22.441] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:22.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:4:0) after 1m0s
[22:43:22.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:4:0)
[22:43:22.511] Timer tick, asking Buildbucket for the build status
[22:43:22.725] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:22.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:5:0) after 1m0s
[22:44:22.712] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:5:0)
[22:44:22.712] Timer tick, asking Buildbucket for the build status
[22:44:23.441] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:23.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:6:0) after 1m0s
[22:45:23.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:6:0)
[22:45:23.483] Timer tick, asking Buildbucket for the build status
[22:45:24.256] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:24.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:7:0) after 1m0s
[22:46:24.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:7:0)
[22:46:24.302] Timer tick, asking Buildbucket for the build status
[22:46:25.568] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:25.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:8:0) after 1m0s
[22:47:25.592] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:8:0)
[22:47:25.592] Timer tick, asking Buildbucket for the build status
[22:47:25.739] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:25.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:9:0) after 1m0s
[22:48:25.910] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:9:0)
[22:48:25.910] Timer tick, asking Buildbucket for the build status
[22:48:26.139] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:26.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:10:0) after 1m0s
[22:49:26.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:10:0)
[22:49:26.165] Timer tick, asking Buildbucket for the build status
[22:49:26.409] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:26.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:11:0) after 1m0s
[22:50:26.500] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:11:0)
[22:50:26.500] Timer tick, asking Buildbucket for the build status
[22:50:27.050] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:27.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:12:0) after 1m0s
[22:51:27.172] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:12:0)
[22:51:27.172] Timer tick, asking Buildbucket for the build status
[22:51:28.633] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:28.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:13:0) after 1m0s
[22:52:28.769] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:13:0)
[22:52:28.769] Timer tick, asking Buildbucket for the build status
[22:52:30.507] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:30.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:14:0) after 1m0s
[22:53:30.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:14:0)
[22:53:30.521] Timer tick, asking Buildbucket for the build status
[22:53:30.992] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:30.992] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:15:0) after 1m0s
[22:54:31.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:15:0)
[22:54:31.085] Timer tick, asking Buildbucket for the build status
[22:54:32.057] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:32.058] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:16:0) after 1m0s
[22:55:32.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:16:0)
[22:55:32.129] Timer tick, asking Buildbucket for the build status
[22:55:33.116] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:33.116] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:17:0) after 1m0s
[22:56:33.133] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:17:0)
[22:56:33.133] Timer tick, asking Buildbucket for the build status
[22:56:33.304] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:33.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:18:0) after 1m0s
[22:57:33.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:18:0)
[22:57:33.424] Timer tick, asking Buildbucket for the build status
[22:57:33.630] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:33.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:19:0) after 1m0s
[22:58:33.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:19:0)
[22:58:33.672] Timer tick, asking Buildbucket for the build status
[22:58:33.839] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:33.839] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:20:0) after 1m0s
[22:59:33.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:20:0)
[22:59:33.876] Timer tick, asking Buildbucket for the build status
[22:59:34.084] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:34.084] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:21:0) after 1m0s
[23:00:34.176] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:21:0)
[23:00:34.176] Timer tick, asking Buildbucket for the build status
[23:00:34.782] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:34.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:22:0) after 1m0s
[23:01:34.899] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:22:0)
[23:01:34.899] Timer tick, asking Buildbucket for the build status
[23:01:35.872] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:35.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:23:0) after 1m0s
[23:02:36.413] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:23:0)
[23:02:36.413] Timer tick, asking Buildbucket for the build status
[23:02:39.854] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:39.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:24:0) after 1m0s
[23:03:40.235] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:24:0)
[23:03:40.235] Timer tick, asking Buildbucket for the build status
[23:03:40.353] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:40.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:25:0) after 1m0s
[23:04:40.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:25:0)
[23:04:40.406] Timer tick, asking Buildbucket for the build status
[23:04:40.769] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:40.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:26:0) after 1m0s
[23:05:40.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:26:0)
[23:05:40.809] Timer tick, asking Buildbucket for the build status
[23:05:41.129] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:41.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:27:0) after 1m0s
[23:06:41.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:27:0)
[23:06:41.169] Timer tick, asking Buildbucket for the build status
[23:06:41.350] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:41.350] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:28:0) after 1m0s
[23:07:41.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:28:0)
[23:07:41.663] Timer tick, asking Buildbucket for the build status
[23:07:42.011] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:42.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:29:0) after 1m0s
[23:08:42.069] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:29:0)
[23:08:42.069] Timer tick, asking Buildbucket for the build status
[23:08:42.689] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:42.689] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:30:0) after 1m0s
[23:09:42.762] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:30:0)
[23:09:42.762] Timer tick, asking Buildbucket for the build status
[23:09:42.953] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:42.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:31:0) after 1m0s
[23:10:42.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:31:0)
[23:10:42.963] Timer tick, asking Buildbucket for the build status
[23:10:45.279] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:45.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:32:0) after 1m0s
[23:11:45.314] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:32:0)
[23:11:45.314] Timer tick, asking Buildbucket for the build status
[23:11:45.668] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:45.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:33:0) after 1m0s
[23:12:45.720] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:33:0)
[23:12:45.720] Timer tick, asking Buildbucket for the build status
[23:12:45.954] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:45.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:34:0) after 1m0s
[23:13:45.941] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:34:0)
[23:13:45.941] Timer tick, asking Buildbucket for the build status
[23:13:47.531] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:47.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:35:0) after 1m0s
[23:14:47.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:35:0)
[23:14:47.632] Timer tick, asking Buildbucket for the build status
[23:14:48.206] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:48.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:36:0) after 1m0s
[23:15:48.399] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:36:0)
[23:15:48.399] Timer tick, asking Buildbucket for the build status
[23:15:48.571] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:48.571] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:37:0) after 1m0s
[23:16:48.690] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:37:0)
[23:16:48.690] Timer tick, asking Buildbucket for the build status
[23:16:50.928] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:50.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:38:0) after 1m0s
[23:17:51.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:38:0)
[23:17:51.108] Timer tick, asking Buildbucket for the build status
[23:17:51.362] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:51.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:39:0) after 1m0s
[23:18:51.433] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:39:0)
[23:18:51.433] Timer tick, asking Buildbucket for the build status
[23:18:51.646] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:51.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:40:0) after 1m0s
[23:19:51.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:40:0)
[23:19:51.714] Timer tick, asking Buildbucket for the build status
[23:19:51.903] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:51.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:41:0) after 1m0s
[23:20:52.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:41:0)
[23:20:52.199] Timer tick, asking Buildbucket for the build status
[23:20:53.965] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:53.965] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:42:0) after 1m0s
[23:21:54.041] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:42:0)
[23:21:54.041] Timer tick, asking Buildbucket for the build status
[23:21:54.728] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:54.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:43:0) after 1m0s
[23:22:54.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:43:0)
[23:22:54.839] Timer tick, asking Buildbucket for the build status
[23:22:55.201] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:55.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:44:0) after 1m0s
[23:23:55.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:44:0)
[23:23:55.630] Timer tick, asking Buildbucket for the build status
[23:23:55.848] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:55.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:45:0) after 1m0s
[23:24:55.907] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:45:0)
[23:24:55.907] Timer tick, asking Buildbucket for the build status
[23:24:56.433] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:56.433] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:46:0) after 1m0s
[23:25:56.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:46:0)
[23:25:56.492] Timer tick, asking Buildbucket for the build status
[23:25:57.029] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:57.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:47:0) after 1m0s
[23:26:57.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:47:0)
[23:26:57.134] Timer tick, asking Buildbucket for the build status
[23:26:58.113] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:58.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:48:0) after 1m0s
[23:27:58.200] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:48:0)
[23:27:58.200] Timer tick, asking Buildbucket for the build status
[23:27:58.400] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:58.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:49:0) after 1m0s
[23:28:58.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:49:0)
[23:28:58.561] Timer tick, asking Buildbucket for the build status
[23:28:58.997] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:58.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:50:0) after 1m0s
[23:29:59.100] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:50:0)
[23:29:59.100] Timer tick, asking Buildbucket for the build status
[23:29:59.393] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:59.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:51:0) after 1m0s
[23:30:59.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:51:0)
[23:30:59.559] Timer tick, asking Buildbucket for the build status
[23:30:59.835] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:59.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:52:0) after 1m0s
[23:31:59.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:52:0)
[23:31:59.929] Timer tick, asking Buildbucket for the build status
[23:32:01.948] Build 8891248505649351936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:01.948] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:53:0) after 1m0s
[23:33:02.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056678567788632624:53:0)
[23:33:02.157] Timer tick, asking Buildbucket for the build status
[23:33:02.737] Build 8891248505649351936: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:33:02.737] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1579044781082145",
"created_by": "project:chromium",
"created_ts": "1579041681584842",
"id": "8891248505649351936",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d37592146efbad662b4f263e488799eff8858370\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-49-5e9c\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 167378, \"got_angle_revision\": \"feb3b6cc6f2b598d001a1166ff03ac64e20de013\", \"got_dawn_revision\": \"cd170a5c7216cfe26572bf380bdfd2e843c1a207\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"d37592146efbad662b4f263e488799eff8858370\", \"got_revision_cp\": \"refs/heads/master@{#731699}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"146e16f68fdc4678600031ab3256cccf7b32d5e2\", \"got_v8_revision\": \"85f423a4d84295de3950317c7dcc490cd754632d\", \"got_v8_revision_cp\": \"refs/heads/8.1.182@{#1}\", \"got_webrtc_revision\": \"b42aeaa3fb21d78e59c47d2a9916acb380494496\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30212}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d37592146efbad662b4f263e488799eff8858370\", \"swarm_hashes_refs/heads/master(at){#731699}_without_patch\": {\"accessibility_unittests\": \"6fbf094488da21540ad8803447f066f718bce354\", \"angle_unittests\": \"db2b3ed4f7c75272fba3948a29bc6a38dc8db3c6\", \"app_shell_unittests\": \"aaa9991b04a318e2d91ff1222c3f7073f8e00d14\", \"aura_unittests\": \"d17cac8d20ae73beaab25edb1dedbcaff66e9dd8\", \"base_unittests\": \"8d0ab1bf3c86cb2d36fad755e93d51f95c80b453\", \"base_util_unittests\": \"08cfee4487f0ba47f8b96259a7c9eb98704aa764\", \"blink_common_unittests\": \"a22783d2d1b264246a6dcc852f88d4ec141936be\", \"blink_fuzzer_unittests\": \"ad0736830bb21aa29b256ce35d3a60bd08c5b68e\", \"blink_heap_unittests\": \"9984b3c0897ea112f921fd38cb66ccd02a0c381d\", \"blink_platform_unittests\": \"1e77cdb182a7b3a388bdacdaa0fac1913dfc5cc0\", \"blink_python_tests\": \"f940d8328d6bdb6e553bc0ae1f7f4a63c7e6c0a1\", \"blink_unittests\": \"642fb93487c32d24bf2cf48b038ff94c057477df\", \"blink_web_tests\": \"a92137c4118ec58a57d26c238afb4ac1498e9d91\", \"boringssl_crypto_tests\": \"37d0bdc84edb682f7dadc0dfd985186b1777d6ee\", \"boringssl_ssl_tests\": \"f44e107f53be79674cbbf56414199fae2a3e4437\", \"browser_tests\": \"b1f73833164f2f159ac9fb2e5852fae66705156a\", \"cacheinvalidation_unittests\": \"44fdc08596c1b78a7c70b0bd67ee3920add26ced\", \"capture_unittests\": \"fd82e7edf3510b679abf2e038d1a299edc1bc246\", \"cast_unittests\": \"a9ba03b2bbf4e5d51819a051a799ccdb25ce0d4d\", \"cc_unittests\": \"a852a4a64862a4530cc84374078f086806ad3080\", \"chrome_app_unittests\": \"89a4663b7f90c90114f25fefc8039c3d2ad20f20\", \"chromedriver_unittests\": \"4dcfd3543828095afb4adbfd59d066acfdfd459f\", \"components_browsertests\": \"15f4f2f807b0957d63c5a0dc0408b5fab1e4f8e0\", \"components_unittests\": \"25b4635fcf22aece9814bc43eb26f3889954f956\", \"compositor_unittests\": \"a281f58e9074b9ba0c1aa6d903638ab63c7ffd15\", \"content_browsertests\": \"41441c1fbccef37972fd4a4a350362d44a6d2467\", \"content_shell_crash_test\": \"a1d881c5b13075ab80043c80adc55b6518ce8bc3\", \"content_unittests\": \"61cfd67c3f887c46bbd2b3fee9de5d19cf8fa396\", \"crashpad_tests\": \"09b252bf09b2b08c773a000f20f815acc0aa930e\", \"cronet_tests\": \"0672d26de8b60ba07ab7bcff22b41d1105d24350\", \"cronet_unittests\": \"4c74c3d9422b9daa8d0603bda93059ca5b4c5f98\", \"crypto_unittests\": \"aec0b7c032fdbbe41cfd7abe81e1c7ca2274a988\", \"dbus_unittests\": \"86109f30d94b3af92bfbbcdc306b5972d29192ef\", \"device_unittests\": \"35d6ade6cdcbfb200ef050016e735dc666e56427\", \"devtools_lint_check\": \"9a49a1253d4195df1baf553d4cef77ac6e706111\", \"devtools_type_check\": \"0a7c0115fbeb83cafccfca422610227ff4406746\", \"display_unittests\": \"c53cffa760ef1f60713767da3fd3340321fc9d06\", \"events_unittests\": \"b60601017f2b33d83ed934c4b67a6226ec10356f\", \"extensions_browsertests\": \"debce35bab0bf0fea1651bf73465848769577817\", \"extensions_unittests\": \"e9cc328f82074c9de4631536683bd30f7d346023\", \"filesystem_service_unittests\": \"c4a5f42bc72742ab77f997321fd1ab3f9e4b7417\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"6f15a5292c04dd3a1586eb1677731622c8272104\", \"gfx_unittests\": \"6f5c5d91755538e06d695d497d7545465b70a356\", \"gin_unittests\": \"94c4edef0fd5f9fe9db1352a613d0a3dc71c1227\", \"google_apis_unittests\": \"997a0d7d7d9e6a5787bc5fe64c982bc11bb656e5\", \"gpu_unittests\": \"351239329b22c86e07aaf09a682f2c91c5efd987\", \"grit_python_unittests\": \"5ba70f2d123ffe8977591ea0b82d6185e7fe166f\", \"gwp_asan_unittests\": \"2b273d962ea02c5a603cee6368c071e400a25d5c\", \"headless_browsertests\": \"c6330c2e82f4dcdb7913b970be72f346537a84e4\", \"headless_unittests\": \"255fe60945901fb352ae378227d110fdc509e12e\", \"interactive_ui_tests\": \"df5d3b92fecdafcc94eecd997afb5ccef18795b8\", \"ipc_tests\": \"eca68c054ef4bd5615a8f8a9fe598263d896b668\", \"jingle_unittests\": \"9aee7285a9128d56df4f3a3ac9a503e131a366e2\", \"latency_unittests\": \"1dc30099c4d2c3b6da44535167f586d09ee656d4\", \"libjingle_xmpp_unittests\": \"d2e15e896b4305d21a3037ac08f542f5adaec154\", \"media_blink_unittests\": \"167a03f459b0e9e75d65ef475d64ff6195503283\", \"media_service_unittests\": \"1febf581b3683bf11d76f88a74810acca07311d4\", \"media_unittests\": \"4b522258dfaa95ca89c383ea9b7918ba256a8e98\", \"message_center_unittests\": \"6a0da876c167195f758586e476d890e76860d48c\", \"metrics_python_tests\": \"0d81c441dc043ec2b34f2ea2912c26fed7904f32\", \"midi_unittests\": \"bd2df2c69fed7516248962644d66399555f69e88\", \"mojo_core_unittests\": \"15a05212ea81b7aa29aafa1c65cc12c5e631e47e\", \"mojo_unittests\": \"bf20952e43a3e58c57934653e50e0e67c2b4dec4\", \"nacl_helper_nonsfi_unittests\": \"db75a68c598289df495611d8cea93d55c800a92f\", \"nacl_loader_unittests\": \"1bb77deab4866129d58dde0ff4a8424e3b511881\", \"native_theme_unittests\": \"40be20ff241f2efc23c0d1a3cf96a05abdf4fc01\", \"net_unittests\": \"6b708f9f8184915cf80989d123fe7a6ec89e2cd6\", \"pdf_unittests\": \"6e38500964b3913521929545f1038c7d3d2af520\", \"perfetto_unittests\": \"4c8b55ad6dff66396238eeff3e17b71d9534b752\", \"ppapi_unittests\": \"a4863aca28d2d62a7c5990dd0d16336125bb3705\", \"printing_unittests\": \"536e0702180a55b49ddb0c94204874f43a384fa1\", \"remoting_unittests\": \"30b0687730a253fd89287ed594f4e7740b569ab3\", \"sandbox_linux_unittests\": \"a640317c2a41f25d78496941c658580866a2d003\", \"service_manager_unittests\": \"2338f08bc3f375dc607978e918b0ee3c37cc60d6\", \"services_unittests\": \"b55cb2a2b084da8ea696cf3def0d56f6f1e7b8bc\", \"shell_dialogs_unittests\": \"3c80f81f2060b0df66d5b124e62f53f61ac7f3eb\", \"skia_unittests\": \"beb0e83896e0e24f13d0dab384ec0a30f7529bfb\", \"snapshot_unittests\": \"c5efa7b4a90e89a17e4c1479065e758e433250cb\", \"sql_unittests\": \"e03b894fccadd5e6925b60d82d846d6bee5c8272\", \"storage_unittests\": \"10aaa3ea7244deb17afab63ee0afc50e31071a2b\", \"sync_integration_tests\": \"13bd599f9a806922d0e30129d3d2b29c750f7f7e\", \"telemetry_gpu_unittests\": \"03ec0e4c3b52778ca938191cd5ec60eb0abf5640\", \"telemetry_perf_unittests\": \"350f7cddffbec3562b6de93de18d3ced26777b64\", \"telemetry_unittests\": \"af7ac8a6a49f645b6df651e345d2d26faffe27b3\", \"traffic_annotation_auditor_unittests\": \"d39a8f7953f4a06b0b5d26aa2335d64a1cfba2bc\", \"ui_base_unittests\": \"d5c60eff34b7ad8bf354328bbdf01b6d9abd8c0c\", \"ui_touch_selection_unittests\": \"84dd4d3992b9fff8886970053af7c0370b77efa3\", \"unit_tests\": \"5441b1503b687357141bddbb7a16214be1cfb4ea\", \"url_unittests\": \"40a80672702356f377e2273c828d9eb153f8af1d\", \"views_perftests\": \"251c606e54640c3c6d9d0b93244990e49902301a\", \"views_unittests\": \"14dfed32076447f3d1d6c1d166769e0dd108b174\", \"viz_unittests\": \"e2e9ec4ec60771b0efd159d16c6a80e8ff5f7489\", \"vr_common_unittests\": \"b0679e0efa61f3a4cc65b5e7c097cc6f89e00763\", \"vr_pixeltests\": \"537cd7099b3e7eb05514c9ea8498983d7b3e2e67\", \"webdriver_wpt_tests\": \"f31907081aa2643a8b201e83963986e997a219ca\", \"weblayer_browsertests\": \"dce3db4522ed27e4f0a63bb81acd3956cbbcfa47\", \"wm_unittests\": \"38bec36af32cedc2547807c0028b4cb68bbaec89\", \"wtf_unittests\": \"679d6746b0f49e805e49c93ba538e65378c0a1fc\", \"xr_browser_tests\": \"664c973402ed6ca325e873e546f850404ed95757\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_349392596e0d17d3422c55529f4e230875f36ec061130c176581539a4c7cd365_v2\", \"builder_71ab4550ecc1db180544ee9bd5ebac58222d39ccc6e59d756fcde46903b3067c_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_e5bbff72983945f6847543519ce1052420cedd06fb8495f4080bfa2e6bcfd13f_v2\", \"builder_f568157a4ec00fb9568da05a054c670841713183d1f68e80f18d1b79a7a19e1f_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-49-5e9c\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4760-d9a0e6d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1579041713811975",
"status": "COMPLETED",
"status_changed_ts": "1579044781692515",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167378",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d37592146efbad662b4f263e488799eff8858370",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d37592146efbad662b4f263e488799eff8858370",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056678567788632624",
"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/8891248505649351936/+/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:49bf09eaf3847c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1579044781700539",
"url": "https://ci.chromium.org/b/8891248505649351936",
"utcnow_ts": "1579044782715863"
}
}
[23:33:02.737] Invocation finished in 51m42.576423673s with status SUCCEEDED