[20:57:57.422] New invocation is queued and will start shortly
[20:57:58.488] Starting the invocation (attempt 1)
[20:57:58.546] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:57:58.546] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:57:58.546] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054057759821217328",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b080602148067b355d4fd858495e147335db65f8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054057759821217328",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/b080602148067b355d4fd858495e147335db65f8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b080602148067b355d4fd858495e147335db65f8",
"gitiles_ref:refs/heads/master"
]
}
[20:57:59.197] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581541078685698",
"id": "8888627697835054128",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b080602148067b355d4fd858495e147335db65f8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581541079050934",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168531",
"builder:Linux Builder (dbg)",
"buildset:commit/git/b080602148067b355d4fd858495e147335db65f8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b080602148067b355d4fd858495e147335db65f8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054057759821217328",
"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/8888627697835054128/+/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": "1581541079051085",
"url": "https://ci.chromium.org/b/8888627697835054128",
"utcnow_ts": "1581541079189964"
}
}
[20:57:59.197] Task URL: https://ci.chromium.org/b/8888627697835054128
[20:57:59.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:2:0) after 1m0s
[20:58:59.298] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:2:0)
[20:58:59.298] Timer tick, asking Buildbucket for the build status
[20:58:59.436] Build 8888627697835054128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:58:59.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:3:0) after 1m0s
[20:59:59.491] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:3:0)
[20:59:59.491] Timer tick, asking Buildbucket for the build status
[20:59:59.651] Build 8888627697835054128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:59:59.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:4:0) after 1m0s
[21:00:59.750] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:4:0)
[21:00:59.750] Timer tick, asking Buildbucket for the build status
[21:01:00.492] Build 8888627697835054128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:00.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:5:0) after 1m0s
[21:02:00.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:5:0)
[21:02:00.534] Timer tick, asking Buildbucket for the build status
[21:02:01.330] Build 8888627697835054128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:01.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:6:0) after 1m0s
[21:03:01.422] Received PubSub notification, asking Buildbucket for the build status
[21:03:01.542] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:01.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:6:0)
[21:03:01.885] Timer tick, asking Buildbucket for the build status
[21:03:02.218] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:02.218] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:8:0) after 1m0s
[21:04:02.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:8:0)
[21:04:02.323] Timer tick, asking Buildbucket for the build status
[21:04:02.546] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:02.546] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:9:0) after 1m0s
[21:05:02.606] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:9:0)
[21:05:02.606] Timer tick, asking Buildbucket for the build status
[21:05:03.383] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:03.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:10:0) after 1m0s
[21:06:03.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:10:0)
[21:06:03.381] Timer tick, asking Buildbucket for the build status
[21:06:03.553] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:03.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:11:0) after 1m0s
[21:07:03.580] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:11:0)
[21:07:03.581] Timer tick, asking Buildbucket for the build status
[21:07:04.270] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:04.270] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:12:0) after 1m0s
[21:08:04.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:12:0)
[21:08:04.329] Timer tick, asking Buildbucket for the build status
[21:08:04.494] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:04.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:13:0) after 1m0s
[21:09:04.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:13:0)
[21:09:04.561] Timer tick, asking Buildbucket for the build status
[21:09:05.731] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:05.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:14:0) after 1m0s
[21:10:05.764] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:14:0)
[21:10:05.764] Timer tick, asking Buildbucket for the build status
[21:10:05.930] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:05.930] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:15:0) after 1m0s
[21:11:05.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:15:0)
[21:11:05.977] Timer tick, asking Buildbucket for the build status
[21:11:06.260] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:06.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:16:0) after 1m0s
[21:12:06.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:16:0)
[21:12:06.379] Timer tick, asking Buildbucket for the build status
[21:12:06.553] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:06.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:17:0) after 1m0s
[21:13:06.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:17:0)
[21:13:06.666] Timer tick, asking Buildbucket for the build status
[21:13:06.840] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:06.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:18:0) after 1m0s
[21:14:06.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:18:0)
[21:14:06.991] Timer tick, asking Buildbucket for the build status
[21:14:07.606] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:07.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:19:0) after 1m0s
[21:15:07.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:19:0)
[21:15:07.705] Timer tick, asking Buildbucket for the build status
[21:15:08.279] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:08.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:20:0) after 1m0s
[21:16:08.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:20:0)
[21:16:08.454] Timer tick, asking Buildbucket for the build status
[21:16:08.658] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:08.658] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:21:0) after 1m0s
[21:17:08.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:21:0)
[21:17:08.710] Timer tick, asking Buildbucket for the build status
[21:17:08.847] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:08.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:22:0) after 1m0s
[21:18:08.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:22:0)
[21:18:08.913] Timer tick, asking Buildbucket for the build status
[21:18:09.023] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:09.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:23:0) after 1m0s
[21:19:09.044] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:23:0)
[21:19:09.044] Timer tick, asking Buildbucket for the build status
[21:19:11.682] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:11.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:24:0) after 1m0s
[21:20:11.703] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:24:0)
[21:20:11.704] Timer tick, asking Buildbucket for the build status
[21:20:12.263] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:12.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:25:0) after 1m0s
[21:21:12.332] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:25:0)
[21:21:12.332] Timer tick, asking Buildbucket for the build status
[21:21:12.531] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:12.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:26:0) after 1m0s
[21:22:12.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:26:0)
[21:22:12.550] Timer tick, asking Buildbucket for the build status
[21:22:13.097] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:13.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:27:0) after 1m0s
[21:23:13.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:27:0)
[21:23:13.099] Timer tick, asking Buildbucket for the build status
[21:23:13.266] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:13.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:28:0) after 1m0s
[21:24:13.288] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:28:0)
[21:24:13.288] Timer tick, asking Buildbucket for the build status
[21:24:13.840] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:13.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:29:0) after 1m0s
[21:25:13.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:29:0)
[21:25:13.846] Timer tick, asking Buildbucket for the build status
[21:25:14.008] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:14.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:30:0) after 1m0s
[21:26:14.237] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:30:0)
[21:26:14.237] Timer tick, asking Buildbucket for the build status
[21:26:14.410] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:14.410] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:31:0) after 1m0s
[21:27:14.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:31:0)
[21:27:14.465] Timer tick, asking Buildbucket for the build status
[21:27:15.058] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:15.058] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:32:0) after 1m0s
[21:28:15.135] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:32:0)
[21:28:15.135] Timer tick, asking Buildbucket for the build status
[21:28:15.317] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:15.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:33:0) after 1m0s
[21:29:15.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:33:0)
[21:29:15.351] Timer tick, asking Buildbucket for the build status
[21:29:15.518] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:15.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:34:0) after 1m0s
[21:30:15.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:34:0)
[21:30:15.666] Timer tick, asking Buildbucket for the build status
[21:30:17.052] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:17.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:35:0) after 1m0s
[21:31:17.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:35:0)
[21:31:17.116] Timer tick, asking Buildbucket for the build status
[21:31:17.295] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:17.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:36:0) after 1m0s
[21:32:17.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:36:0)
[21:32:17.367] Timer tick, asking Buildbucket for the build status
[21:32:17.789] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:17.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:37:0) after 1m0s
[21:33:17.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:37:0)
[21:33:17.823] Timer tick, asking Buildbucket for the build status
[21:33:18.980] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:18.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:38:0) after 1m0s
[21:34:19.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:38:0)
[21:34:19.059] Timer tick, asking Buildbucket for the build status
[21:34:19.582] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:19.582] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:39:0) after 1m0s
[21:35:19.588] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:39:0)
[21:35:19.588] Timer tick, asking Buildbucket for the build status
[21:35:20.390] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:20.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:40:0) after 1m0s
[21:36:20.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:40:0)
[21:36:20.422] Timer tick, asking Buildbucket for the build status
[21:36:20.797] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:20.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:41:0) after 1m0s
[21:37:20.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:41:0)
[21:37:20.825] Timer tick, asking Buildbucket for the build status
[21:37:21.043] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:21.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:42:0) after 1m0s
[21:38:21.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:42:0)
[21:38:21.059] Timer tick, asking Buildbucket for the build status
[21:38:21.731] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:21.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:43:0) after 1m0s
[21:39:21.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:43:0)
[21:39:21.749] Timer tick, asking Buildbucket for the build status
[21:39:22.497] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:22.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:44:0) after 1m0s
[21:40:22.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:44:0)
[21:40:22.578] Timer tick, asking Buildbucket for the build status
[21:40:22.945] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:22.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:45:0) after 1m0s
[21:41:23.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:45:0)
[21:41:23.142] Timer tick, asking Buildbucket for the build status
[21:41:23.308] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:23.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:46:0) after 1m0s
[21:42:23.433] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:46:0)
[21:42:23.433] Timer tick, asking Buildbucket for the build status
[21:42:23.599] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:23.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:47:0) after 1m0s
[21:43:23.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:47:0)
[21:43:23.732] Timer tick, asking Buildbucket for the build status
[21:43:23.874] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:23.874] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:48:0) after 1m0s
[21:44:24.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:48:0)
[21:44:24.000] Timer tick, asking Buildbucket for the build status
[21:44:24.757] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:24.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:49:0) after 1m0s
[21:45:24.767] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:49:0)
[21:45:24.767] Timer tick, asking Buildbucket for the build status
[21:45:24.985] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:24.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:50:0) after 1m0s
[21:46:25.055] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:50:0)
[21:46:25.055] Timer tick, asking Buildbucket for the build status
[21:46:25.277] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:25.277] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:51:0) after 1m0s
[21:47:25.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:51:0)
[21:47:25.446] Timer tick, asking Buildbucket for the build status
[21:47:25.618] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:25.618] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:52:0) after 1m0s
[21:48:25.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:52:0)
[21:48:25.801] Timer tick, asking Buildbucket for the build status
[21:48:25.939] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:25.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:53:0) after 1m0s
[21:49:26.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:53:0)
[21:49:26.337] Timer tick, asking Buildbucket for the build status
[21:49:26.492] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:26.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:54:0) after 1m0s
[21:50:26.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:54:0)
[21:50:26.651] Timer tick, asking Buildbucket for the build status
[21:50:26.910] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:26.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:55:0) after 1m0s
[21:51:27.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:55:0)
[21:51:27.087] Timer tick, asking Buildbucket for the build status
[21:51:27.238] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:27.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:56:0) after 1m0s
[21:52:27.320] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:56:0)
[21:52:27.320] Timer tick, asking Buildbucket for the build status
[21:52:27.519] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:27.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:57:0) after 1m0s
[21:53:27.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:57:0)
[21:53:27.702] Timer tick, asking Buildbucket for the build status
[21:53:28.061] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:28.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:58:0) after 1m0s
[21:54:28.145] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:58:0)
[21:54:28.145] Timer tick, asking Buildbucket for the build status
[21:54:28.321] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:28.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:59:0) after 1m0s
[21:55:28.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:59:0)
[21:55:28.552] Timer tick, asking Buildbucket for the build status
[21:55:28.728] Build 8888627697835054128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:28.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054057759821217328:60:0) after 1m0s
[21:56:10.890] Received PubSub notification, asking Buildbucket for the build status
[21:56:11.017] Build 8888627697835054128: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:56:11.017] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581544538941616",
"created_by": "project:chromium",
"created_ts": "1581541078685698",
"id": "8888627697835054128",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b080602148067b355d4fd858495e147335db65f8\"}}",
"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\"}, \"$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-east1-d-8-94-1m7i\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168531, \"got_angle_revision\": \"92b00ca882637cfaff897e689dcc50fa20c31143\", \"got_dawn_revision\": \"2fd618192985122aafb494ac5e9a39f572ef46fc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"b080602148067b355d4fd858495e147335db65f8\", \"got_revision_cp\": \"refs/heads/master@{#740811}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"d5a2a597ceb4168edb48401c7a0ca650dd60c5aa\", \"got_v8_revision\": \"f4ae4cac20bc22d93b35b3effd92074a3546252f\", \"got_v8_revision_cp\": \"refs/heads/8.2.63@{#1}\", \"got_webrtc_revision\": \"d4c3c3a454215b21f02d2a772a729b4c87d6b33e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30486}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b080602148067b355d4fd858495e147335db65f8\", \"swarm_hashes_refs/heads/master(at){#740811}_without_patch\": {\"accessibility_unittests\": \"8d870ae7a19b370bab75bc8776226dbac2705007\", \"angle_unittests\": \"84fb18541fd204370ee0dcfc7424b107271f1509\", \"app_shell_unittests\": \"23309f9554f36e4264dd2fd7f7aaedae38e5822f\", \"aura_unittests\": \"5d1da34ba4c5490d863733d425ced2d8bc6546b5\", \"base_unittests\": \"0f4243fd6eb9bc8685b789ccfdc3029aa646b719\", \"base_util_unittests\": \"e07f81e83648f086d2ee4f1fdd6397a218119c71\", \"blink_common_unittests\": \"feb52a37d43cd9b1759141b5152d67c5b0279a97\", \"blink_fuzzer_unittests\": \"810ca24e38492852c6eba652a0217ba6b9fd5c0b\", \"blink_heap_unittests\": \"a35279862ad973b3bfcc8c97de8fcfd24ebeffcb\", \"blink_platform_unittests\": \"3f3ff01f58cb6d42b1f47f1fa1305dd8594e3bda\", \"blink_python_tests\": \"66bde6efa279a740cbfa909e1cee6aef8a589b63\", \"blink_unittests\": \"855aba6647e41ff42e043cf9f08b0b7e4e090ac8\", \"blink_web_tests\": \"21cfae2cfc38f98a68136ed6fcec02c0d2a6406a\", \"boringssl_crypto_tests\": \"7a4aeeb2a5641458b758d37dd00a2f0a8855a928\", \"boringssl_ssl_tests\": \"f90f19a36cce40ce2a9948261f5acba7643e7d4d\", \"browser_tests\": \"486a71d9b10af00304d20c813dab3a4928673ad9\", \"cacheinvalidation_unittests\": \"9f4de96cf28f66af4357880d71afaba2137f5ebf\", \"capture_unittests\": \"1847f97a5adcf6bd06320118ce27831c3cbc7a5d\", \"cast_unittests\": \"d837cc445985d4ff0f25a34e2972b49da1ed8402\", \"cc_unittests\": \"09b33d87c836472ffe8f6d6dfbfcb8bd546addee\", \"chrome_app_unittests\": \"94742947c783948f161003bad3d002f75e4a70b7\", \"chromedriver_unittests\": \"76d406cf6f155c3cc97ce6ab59deb1567fe1414a\", \"components_browsertests\": \"b74628612c29962e81e33dc1247a768e1c901cd7\", \"components_unittests\": \"78525b4b5da4f6ee0e0dc4afa0c448d318504be4\", \"compositor_unittests\": \"554865c938552a1cb37f8e886304897edb30cfbe\", \"content_browsertests\": \"b532f9aadf59ca22aafbc90cf1ceef02026c018c\", \"content_shell_crash_test\": \"f9f5a57b6e5d66de506d96d230b0fdef5c0c2c22\", \"content_unittests\": \"76313b2e1e6e51067f2b7effae25315b7a178934\", \"crashpad_tests\": \"9adf16ba1fd39887cc2f1da998f891ab8b1430b1\", \"cronet_tests\": \"b684716c5e9c01efc2f6583890c1eb13f69ba059\", \"cronet_unittests\": \"891e5266839766c6a13a4a0233d5dcb0c493cdc7\", \"crypto_unittests\": \"fd51dcad44f45a9a7308e3038ac224a106f2e643\", \"dbus_unittests\": \"b8ea4b649109fb9ff35ac52cf7d5d119dfa7c548\", \"device_unittests\": \"4eeaa401dcbab39338efec28775187a573cac051\", \"display_unittests\": \"e5553ec236ffe83909db561abda930b1334222b9\", \"events_unittests\": \"07123bd2ca43d9128d8fe2fc1dedd05712ad3f36\", \"extensions_browsertests\": \"9fc154489ae2e79c7beb8fbafefb47e1fe520ec9\", \"extensions_unittests\": \"5e16a7f1f5f3b93046b95130d3379a5c8d1d7aa4\", \"filesystem_service_unittests\": \"1ecb49e790c8c8c3487e2610c47b392bd5696541\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"34397d92cf6f493206b0433b876e62de555095bd\", \"gfx_unittests\": \"a3f2c407135eda81ee2c7295dfbd26bdad651593\", \"gin_unittests\": \"e48e101367e174de587cc64134664ad5485cef83\", \"google_apis_unittests\": \"a9d22408db9ed089f43d34e76d872d5a78f9944a\", \"gpu_unittests\": \"6be0954f7fa27861fc6aae7b041c3443c6300b34\", \"grit_python_unittests\": \"07488c096d20bb2a4e6d9280813fca6afbee6dc0\", \"gwp_asan_unittests\": \"9439da568684747d7188c42e9d4594ce93cbd617\", \"headless_browsertests\": \"93e9ebad646666abb4f0012b01fb99337e55838b\", \"headless_unittests\": \"ca30ded11f0a4fbabed02b93803ea85364c24535\", \"interactive_ui_tests\": \"b8b5b9998cd188cc4e0833dc720e8a500a015a48\", \"ipc_tests\": \"6b76c22541464462b1b48cb4fd20f775632abbc7\", \"jingle_unittests\": \"dd9e54583247fea4bd85e4109386013696a93bb7\", \"latency_unittests\": \"02983acaa1bea9fbbe372206cc530d2194c2c7f6\", \"libjingle_xmpp_unittests\": \"92e0576b40d3299d10aad5fb2e77b8dbf4d77728\", \"media_blink_unittests\": \"853b6515440f7e1390dac729c1b27b166fd6510f\", \"media_service_unittests\": \"7d462b4814ff37f8677aaaabe3f7ecbf4b15e386\", \"media_unittests\": \"cf9127003aeb44e6fdffdd220a3872535cca3149\", \"message_center_unittests\": \"a55cfbe51b5e2fd0f1231087c9cdf07c6e586de7\", \"metrics_python_tests\": \"d3d03b409d4c8a56289764ff548be91eaea1cec6\", \"midi_unittests\": \"c530c345f103318ac20f4feb9a97943ee897f406\", \"mojo_core_unittests\": \"69902fcaed91cb3eb4c49e41b421a857ab7aaca6\", \"mojo_unittests\": \"8c11467088150b24b3d4ac1758aa40b2643c5c45\", \"nacl_helper_nonsfi_unittests\": \"d625be75f86c4b95393a9b8ac769e217fef0944f\", \"nacl_loader_unittests\": \"b273c93458b6227432d157283f8e59a975e6716e\", \"native_theme_unittests\": \"57362a56b1c33c8ad6348726323946760756714e\", \"net_unittests\": \"d43cba18486033d6c2d4ef73a84d162b8219617a\", \"pdf_unittests\": \"3f1b9ca72c4720972107ab9f2c970bbd3654cdd8\", \"perfetto_unittests\": \"1bd2524474a3aadfbb0b5ec7cd9e2955a1ad5322\", \"ppapi_unittests\": \"1528a8ccf2da35a40d2fa9eb597408db51094b4c\", \"printing_unittests\": \"dc830f507a98e7566f399b72d430b240ae8cee38\", \"remoting_unittests\": \"c12c16f7cdec70edd3fa360bf30caee22ec80093\", \"sandbox_linux_unittests\": \"5fd43fb38b3f3189d196ddfc9c00ff38058671c1\", \"service_manager_unittests\": \"5cb5745ac6ca441b64f21fb29790548154395274\", \"services_unittests\": \"5b66d92d8f352fa888bee8f2fc24beb130185789\", \"shell_dialogs_unittests\": \"f21f858ac9fc47ad07f96a1961546350849787be\", \"skia_unittests\": \"963e03bcd33bda15d0fbd7a7bc5eef42fbfce676\", \"snapshot_unittests\": \"d107fe441dfdd0100528ee73f6503a11f55fcc06\", \"sql_unittests\": \"9d7bc30348e2eefbe9de8e1daf5752dc955dfbeb\", \"storage_unittests\": \"8678bbd3311f02ff33511f8122995018b198802b\", \"sync_integration_tests\": \"a8070f41d47a3ef5d0170434d91577dbfac1c8a1\", \"telemetry_gpu_unittests\": \"176b036f9052e0217b70e6eb3d1e13fe1f12e6a5\", \"telemetry_perf_unittests\": \"ec8ce47ebb4ef4314af3fa9e8e0402bebe4f1200\", \"telemetry_unittests\": \"21a5ad15824c2a7af5c8e94625e6d5e9967a1287\", \"traffic_annotation_auditor_unittests\": \"4150844e9287eac56d9fd3911a554fcfa1fe2791\", \"ui_base_unittests\": \"bfc93fa6c624d6b8ea5c84648c628a0fd5a32d3b\", \"ui_touch_selection_unittests\": \"676b701c98a79170b4cd9315efba5ff4f65ab742\", \"unit_tests\": \"4f0ee1c66c4a5393692ef50b89487919fc093c5a\", \"url_unittests\": \"3ef3921059c34c2a53fdc90007ccd930d2a6882f\", \"views_perftests\": \"ab118542b785ca2c39a6019591b544e756a8f3eb\", \"views_unittests\": \"1a0e0816a38e7a4f61467d85ee2542d22b461c85\", \"viz_unittests\": \"ff023564c647b1bd70174b7d069a07f399fa094f\", \"vr_common_unittests\": \"a142847629fa6ae60f0b6b37785b72c942108d03\", \"vr_pixeltests\": \"0936806fbaf491a505fd405c9d55258e82a0ee49\", \"webdriver_wpt_tests\": \"43504eefe66e074aefb39a1add74bf491a669267\", \"weblayer_browsertests\": \"820fc3ec45c705418006e09e8356a940e2e69d1b\", \"wm_unittests\": \"24c30fc3b197fec4ff5a359de548f0d73769d079\", \"wtf_unittests\": \"7827adf21e40d62078c75b185d28ff6d78aba2fc\", \"xr_browser_tests\": \"7f5616f7af7f1eb3a8d6e16c0be109cf1b354173\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2b15148fa2a471165482335bd523b5eee69ace70a2c04528f88245080a969046_v2\", \"builder_65fafd0c860c8cf0043a2ec0f6482d6e089dd429d22310040aa34c8b96106827_v2\", \"builder_81975214af25fe3c157931ccf4182e1c4ae2635ce20b925a941b30b87e2fcb1d_v2\", \"builder_cc8a16e85eefa617bab544f2f33977139159d8b8c3b7333fd512c64ffd131f2c_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-east1-d-8-94-1m7i\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4812-ea7e8fc\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581541376853879",
"status": "COMPLETED",
"status_changed_ts": "1581544570632196",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168531",
"builder:Linux Builder (dbg)",
"buildset:commit/git/b080602148067b355d4fd858495e147335db65f8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b080602148067b355d4fd858495e147335db65f8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054057759821217328",
"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/8888627697835054128/+/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:4a5403411a457f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1581544570636098",
"url": "https://ci.chromium.org/b/8888627697835054128",
"utcnow_ts": "1581544571006246"
}
}
[21:56:11.017] Invocation finished in 58m13.610513295s with status SUCCEEDED