[19:34:30.191] New invocation is queued and will start shortly
[19:34:33.963] Starting the invocation (attempt 1)
[19:34:34.010] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:34:34.010] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:34:34.010] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030507799029959984",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"39fb9728d5cb9079a0fbf1785a03d0fe43364008\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9030507799029959984",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/39fb9728d5cb9079a0fbf1785a03d0fe43364008",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/39fb9728d5cb9079a0fbf1785a03d0fe43364008",
"gitiles_ref:refs/heads/master"
]
}
[19:34:34.922] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604000074124999",
"id": "8865077734233546352",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"39fb9728d5cb9079a0fbf1785a03d0fe43364008\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604000074665438",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177151",
"builder:Linux Builder (dbg)",
"buildset:commit/git/39fb9728d5cb9079a0fbf1785a03d0fe43364008",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/39fb9728d5cb9079a0fbf1785a03d0fe43364008",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030507799029959984",
"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/8865077734233546352/+/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": "1604000074665624",
"url": "https://ci.chromium.org/b/8865077734233546352",
"utcnow_ts": "1604000074910345"
}
}
[19:34:34.922] Task URL: https://ci.chromium.org/b/8865077734233546352
[19:34:34.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:2:0) after 1m0s
[19:34:42.619] Received PubSub notification, asking Buildbucket for the build status
[19:34:42.726] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:35.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:2:0)
[19:35:35.038] Timer tick, asking Buildbucket for the build status
[19:35:35.185] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:35.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:4:0) after 1m0s
[19:36:35.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:4:0)
[19:36:35.221] Timer tick, asking Buildbucket for the build status
[19:36:35.332] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:35.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:5:0) after 1m0s
[19:37:35.353] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:5:0)
[19:37:35.353] Timer tick, asking Buildbucket for the build status
[19:37:35.423] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:35.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:6:0) after 1m0s
[19:38:35.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:6:0)
[19:38:35.481] Timer tick, asking Buildbucket for the build status
[19:38:35.626] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:35.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:7:0) after 1m0s
[19:39:35.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:7:0)
[19:39:35.679] Timer tick, asking Buildbucket for the build status
[19:39:35.827] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:35.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:8:0) after 1m0s
[19:40:35.908] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:8:0)
[19:40:35.908] Timer tick, asking Buildbucket for the build status
[19:40:36.540] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:36.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:9:0) after 1m0s
[19:41:36.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:9:0)
[19:41:36.675] Timer tick, asking Buildbucket for the build status
[19:41:36.920] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:36.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:10:0) after 1m0s
[19:42:37.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:10:0)
[19:42:37.001] Timer tick, asking Buildbucket for the build status
[19:42:37.128] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:37.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:11:0) after 1m0s
[19:43:37.285] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:11:0)
[19:43:37.285] Timer tick, asking Buildbucket for the build status
[19:43:37.361] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:37.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:12:0) after 1m0s
[19:44:37.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:12:0)
[19:44:37.436] Timer tick, asking Buildbucket for the build status
[19:44:37.574] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:37.574] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:13:0) after 1m0s
[19:45:37.715] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:13:0)
[19:45:37.715] Timer tick, asking Buildbucket for the build status
[19:45:37.805] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:37.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:14:0) after 1m0s
[19:46:37.834] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:14:0)
[19:46:37.834] Timer tick, asking Buildbucket for the build status
[19:46:38.088] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:38.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:15:0) after 1m0s
[19:47:38.188] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:15:0)
[19:47:38.188] Timer tick, asking Buildbucket for the build status
[19:47:38.283] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:38.283] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:16:0) after 1m0s
[19:48:38.331] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:16:0)
[19:48:38.331] Timer tick, asking Buildbucket for the build status
[19:48:38.403] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:38.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:17:0) after 1m0s
[19:49:38.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:17:0)
[19:49:38.516] Timer tick, asking Buildbucket for the build status
[19:49:38.757] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:38.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:18:0) after 1m0s
[19:50:38.819] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:18:0)
[19:50:38.819] Timer tick, asking Buildbucket for the build status
[19:50:38.886] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:38.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:19:0) after 1m0s
[19:51:38.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:19:0)
[19:51:38.915] Timer tick, asking Buildbucket for the build status
[19:51:39.479] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:39.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:20:0) after 1m0s
[19:52:39.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:20:0)
[19:52:39.522] Timer tick, asking Buildbucket for the build status
[19:52:39.585] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:39.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:21:0) after 1m0s
[19:53:39.646] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:21:0)
[19:53:39.646] Timer tick, asking Buildbucket for the build status
[19:53:39.731] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:39.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:22:0) after 1m0s
[19:54:39.781] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:22:0)
[19:54:39.781] Timer tick, asking Buildbucket for the build status
[19:54:39.920] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:39.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:23:0) after 1m0s
[19:55:39.999] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:23:0)
[19:55:39.999] Timer tick, asking Buildbucket for the build status
[19:55:40.066] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:40.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:24:0) after 1m0s
[19:56:40.080] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:24:0)
[19:56:40.080] Timer tick, asking Buildbucket for the build status
[19:56:40.284] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:40.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:25:0) after 1m0s
[19:57:40.308] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:25:0)
[19:57:40.308] Timer tick, asking Buildbucket for the build status
[19:57:40.388] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:40.388] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:26:0) after 1m0s
[19:58:40.439] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:26:0)
[19:58:40.439] Timer tick, asking Buildbucket for the build status
[19:58:40.661] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:40.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:27:0) after 1m0s
[19:59:40.683] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:27:0)
[19:59:40.683] Timer tick, asking Buildbucket for the build status
[19:59:40.957] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:40.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:28:0) after 1m0s
[20:00:41.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:28:0)
[20:00:41.000] Timer tick, asking Buildbucket for the build status
[20:00:41.143] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:41.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:29:0) after 1m0s
[20:01:41.227] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:29:0)
[20:01:41.227] Timer tick, asking Buildbucket for the build status
[20:01:41.301] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:41.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:30:0) after 1m0s
[20:02:41.322] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:30:0)
[20:02:41.322] Timer tick, asking Buildbucket for the build status
[20:02:41.414] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:41.414] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:31:0) after 1m0s
[20:03:41.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:31:0)
[20:03:41.512] Timer tick, asking Buildbucket for the build status
[20:03:41.679] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:41.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:32:0) after 1m0s
[20:04:41.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:32:0)
[20:04:41.724] Timer tick, asking Buildbucket for the build status
[20:04:42.149] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:42.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:33:0) after 1m0s
[20:05:42.200] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:33:0)
[20:05:42.200] Timer tick, asking Buildbucket for the build status
[20:05:42.281] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:42.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:34:0) after 1m0s
[20:06:42.342] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:34:0)
[20:06:42.342] Timer tick, asking Buildbucket for the build status
[20:06:42.416] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:42.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:35:0) after 1m0s
[20:07:42.468] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:35:0)
[20:07:42.468] Timer tick, asking Buildbucket for the build status
[20:07:42.675] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:42.675] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:36:0) after 1m0s
[20:08:42.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:36:0)
[20:08:42.714] Timer tick, asking Buildbucket for the build status
[20:08:42.797] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:42.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:37:0) after 1m0s
[20:09:42.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:37:0)
[20:09:42.821] Timer tick, asking Buildbucket for the build status
[20:09:43.202] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:43.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:38:0) after 1m0s
[20:10:43.252] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:38:0)
[20:10:43.252] Timer tick, asking Buildbucket for the build status
[20:10:43.349] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:43.349] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:39:0) after 1m0s
[20:11:43.363] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:39:0)
[20:11:43.363] Timer tick, asking Buildbucket for the build status
[20:11:43.491] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:43.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:40:0) after 1m0s
[20:12:43.588] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:40:0)
[20:12:43.588] Timer tick, asking Buildbucket for the build status
[20:12:43.745] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:43.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:41:0) after 1m0s
[20:13:43.866] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:41:0)
[20:13:43.866] Timer tick, asking Buildbucket for the build status
[20:13:43.944] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:43.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:42:0) after 1m0s
[20:14:43.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:42:0)
[20:14:43.991] Timer tick, asking Buildbucket for the build status
[20:14:44.319] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:44.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:43:0) after 1m0s
[20:15:44.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:43:0)
[20:15:44.318] Timer tick, asking Buildbucket for the build status
[20:15:44.518] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:44.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:44:0) after 1m0s
[20:16:44.646] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:44:0)
[20:16:44.646] Timer tick, asking Buildbucket for the build status
[20:16:44.853] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:44.853] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:45:0) after 1m0s
[20:17:45.007] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:45:0)
[20:17:45.007] Timer tick, asking Buildbucket for the build status
[20:17:45.090] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:45.090] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:46:0) after 1m0s
[20:18:45.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:46:0)
[20:18:45.142] Timer tick, asking Buildbucket for the build status
[20:18:45.293] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:45.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:47:0) after 1m0s
[20:19:45.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:47:0)
[20:19:45.341] Timer tick, asking Buildbucket for the build status
[20:19:45.479] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:45.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:48:0) after 1m0s
[20:20:45.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:48:0)
[20:20:45.723] Timer tick, asking Buildbucket for the build status
[20:20:45.801] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:45.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:49:0) after 1m0s
[20:21:45.961] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:49:0)
[20:21:45.961] Timer tick, asking Buildbucket for the build status
[20:21:46.072] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:46.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:50:0) after 1m0s
[20:22:46.179] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:50:0)
[20:22:46.179] Timer tick, asking Buildbucket for the build status
[20:22:46.244] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:46.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:51:0) after 1m0s
[20:23:46.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:51:0)
[20:23:46.307] Timer tick, asking Buildbucket for the build status
[20:23:46.375] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:46.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:52:0) after 1m0s
[20:24:46.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:52:0)
[20:24:46.521] Timer tick, asking Buildbucket for the build status
[20:24:46.670] Build 8865077734233546352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:46.670] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030507799029959984:53:0) after 1m0s
[20:24:50.771] Received PubSub notification, asking Buildbucket for the build status
[20:24:51.385] Build 8865077734233546352: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:24:51.385] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604003090031927",
"created_by": "project:chromium",
"created_ts": "1604000074124999",
"id": "8865077734233546352",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"39fb9728d5cb9079a0fbf1785a03d0fe43364008\"}}",
"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\": \"39fb9728d5cb9079a0fbf1785a03d0fe43364008\", \"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-130-xu9k\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177151, \"got_angle_revision\": \"68b95b6330b48e05db7b4bcd1d1713951219c173\", \"got_dawn_revision\": \"af64c73c174ce666d7fe7f11427c14b439b62515\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"39fb9728d5cb9079a0fbf1785a03d0fe43364008\", \"got_revision_cp\": \"refs/heads/master@{#822317}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"2be25f08deafe1fb1eada032cd3b2aae3021f367\", \"got_v8_revision\": \"09998672b45d22afc43bade11fa41df55b449375\", \"got_v8_revision_cp\": \"refs/heads/8.8.209@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"39fb9728d5cb9079a0fbf1785a03d0fe43364008\", \"swarm_hashes_refs/heads/master(at){#822317}_without_patch\": {\"absl_hardening_tests\": \"11a536105b28297cb0b290d703d27a105c11ae75\", \"accessibility_unittests\": \"76c96f5a6b2c568d4f4bdd638225c5c0a9dda71a\", \"angle_unittests\": \"179e895e5f2c07a676b3f99bf2c8c8c24fc2c596\", \"app_shell_unittests\": \"980369d02ccf1ceddb86a286738db51474de08d1\", \"aura_unittests\": \"8d20b2504ca8410777c14a491d9e151c1eeec84a\", \"base_unittests\": \"8203512d571ff29850edb26fc8a496968f221d9c\", \"base_util_unittests\": \"a65e701da92a4d6ec0485e1b394670a37f1f0bc0\", \"blink_common_unittests\": \"fa8cb46b651ef312a6294852800fffa02e111ff4\", \"blink_fuzzer_unittests\": \"1e93198ecd72cc7c55abde48b84d5e0e5efbf1f6\", \"blink_heap_unittests\": \"d9ee6aac2f894e9ed439de72c32b45242e643354\", \"blink_platform_unittests\": \"2432fbfe56d9bd49ac668c4d99f82007bcd5f364\", \"blink_python_tests\": \"3e7180d4e7c2a8de887abfd18bbebf29aef5ad5f\", \"blink_unittests\": \"0c07957c23d1fed98eaba34b4e629e5bf412f888\", \"blink_web_tests\": \"00ad3c3bb8de18508c87d309f73a49143e446e75\", \"boringssl_crypto_tests\": \"7786d012649d9ab32c80bd404dfb350249995b7f\", \"boringssl_ssl_tests\": \"1da0f2e6940df7eef2642907df0c7b4b497cba6e\", \"browser_tests\": \"55bdfce2d48e074122a57796e17bef81b383a790\", \"capture_unittests\": \"55ee69cae64fda39669f2c02613bb67413cfb625\", \"cast_unittests\": \"45d5f193174c817311917f3046b586b71bddf5e9\", \"cc_unittests\": \"c4b88e53864e86e032cd40120781b47879670e83\", \"chrome_app_unittests\": \"6a0b23b08a3ba6f06328469c430431a3f163def3\", \"chromedriver_unittests\": \"14660408c34516f41666080b141c0c3ff7dc6b8e\", \"components_browsertests\": \"bd1aac63f7aa275e2718bc4df00fd2b4187062f3\", \"components_unittests\": \"885ac1e7aabf49235363abbd1a69df58c7b446a9\", \"compositor_unittests\": \"b6984d7874e2ad8d1d0d62ec39d0ff1529ca1b2a\", \"content_browsertests\": \"b4af41c1fa26f3fae95b877d51f77346331f9772\", \"content_shell_crash_test\": \"23caae76790108ab7e57c2b0ecf45d2a25307c14\", \"content_unittests\": \"5eee1cc3cd0549af2bb45c4f3b68303895f29c60\", \"crashpad_tests\": \"d3a7a91fbdfb561f4a90a850a89dbdd1d3aa04ed\", \"cronet_tests\": \"4663cce7bc010307e37d80baaf3f067d968c7fb7\", \"cronet_unittests\": \"0ce0a16d7871719169a43427756d3e052533ee8e\", \"crypto_unittests\": \"1336c9ead10ce5c6c267549b95343bd12a37886e\", \"dbus_unittests\": \"e7f2c1cf3002a0293e6d36569858de8ec04b1ea4\", \"device_unittests\": \"0ec1bcae3729138bad18c2a757e05c92b6209879\", \"display_unittests\": \"8cc6d07bc3cb07228a7c254c7cbed4a0f78d66ea\", \"events_unittests\": \"f6f24d0ebf642a6d3a6241b7bc047c105d9080f1\", \"extension_docserver_python_unittests\": \"1cac2f187c4a7c852959d0636c28f434c10f2d0b\", \"extensions_browsertests\": \"62b67bc0f23ecd7a9057f3e220f46711f91d33b4\", \"extensions_unittests\": \"91ba0439260eecd13409aa6a6b93c5c81d75558e\", \"filesystem_service_unittests\": \"1e6c13c22cdc6a82b707c12d5c39560ace3d0905\", \"flatbuffers_unittests\": \"be237720fdbb07e58b96ce0c0382048fec390853\", \"gcm_unit_tests\": \"225454a8cb53572901b5693b43ead4b7f2683dd7\", \"gfx_unittests\": \"a4f1dfba8b0f305359c41f269ab918fa8f7363d9\", \"gin_unittests\": \"f5b069cb9436ff971c5f2fdd78a46e0a3b268e12\", \"google_apis_unittests\": \"3fa0e7952c7ca42f44ae41803c8ebaf828a9e5bf\", \"gpu_unittests\": \"f762f148911a8aa9e64d4d9fdc046d8d0aaa7a8a\", \"grit_python_unittests\": \"920a9227ec095c237c6f68bb9db627b1acb0c480\", \"gwp_asan_unittests\": \"8adfd5333cb47e7edf0f796d12f7c56c54f7d33c\", \"headless_browsertests\": \"e6887492e25325c239eff4cddfb7709042b2a278\", \"headless_unittests\": \"efc633538b284cb967cb3d82dec6fe5311a87354\", \"interactive_ui_tests\": \"123aa6c5d8d809623f40e53b0566c13c21cbef40\", \"ipc_tests\": \"514890ee91f5212186a6c6e0135a2bea0721dbc2\", \"jingle_unittests\": \"fd8220aa15ef278d25b7760745993f939fa64798\", \"latency_unittests\": \"ab76c09218a6a7457ee8865540a8fcf61d977f36\", \"libjingle_xmpp_unittests\": \"16a50f1d07c2d9a600cee4fdf9593eb61b64bc53\", \"liburlpattern_unittests\": \"a263555a962b8dc1dc7d114d101d190d6bada9e6\", \"media_blink_unittests\": \"7d1087f6489c840065b7e1afb278752ce8981913\", \"media_unittests\": \"145542d9060301fdbcf3702ede045eddb11d60fd\", \"message_center_unittests\": \"3af99fb90dd9bfa8ffa8a870d3565d2a5dbb9b70\", \"metrics_python_tests\": \"e7497abdf3af8c03435d25cb2b00b1367c08f6af\", \"midi_unittests\": \"774c87509b343e5ab92d7412a536730b38b48d2e\", \"mojo_core_unittests\": \"46210dad0f7d63b74db99b2a8b5e0edb88ccf12f\", \"mojo_unittests\": \"dee8736ded372bf58f1470fc1315de46c1fc01b5\", \"nacl_helper_nonsfi_unittests\": \"313d1b6e6cf75264fe66f4cb367a79645bbf8ae7\", \"nacl_loader_unittests\": \"c9857f114a1ac7402c77628a765e9a7a3fba9fa5\", \"native_theme_unittests\": \"8934e5e5f38455b816d324efdd99f568a2eddb96\", \"net_unittests\": \"faa377fca15132056e58e27914c8a256ecabf0aa\", \"openscreen_unittests\": \"515fa0e33439d2f803202afa1158375cebe68909\", \"pdf_unittests\": \"878f4a8eb9f110dd7b54484bebc0fbcb969807fe\", \"perfetto_unittests\": \"131490af9091a58b92c0d183653b6a792736a26b\", \"ppapi_unittests\": \"c402a5aaa5478ea6e54a5e893730264874637bd6\", \"printing_unittests\": \"dd19a5d7ed68d38d7f6731f89a84920e389fbdbe\", \"remoting_unittests\": \"85d3d7b863443609cd7a83867d9a3af45b9c286b\", \"sandbox_linux_unittests\": \"a7f4920b9648b6ac8ee3b9a979ec27518d817809\", \"service_manager_unittests\": \"c7544a4c9db36a8d7a0d60228516f284a747bd16\", \"services_unittests\": \"0844d4b343d471ffc976be1334a9b23fd15b4b89\", \"shell_dialogs_unittests\": \"2b9027fe11176243424eb1fb7f0c401e1a0cac9d\", \"skia_unittests\": \"c4f4a26cf7837cd82ce90e41551663ed8b461747\", \"snapshot_unittests\": \"79a6559db560dd2f48786a2823dbe82cbb88fc87\", \"sql_unittests\": \"d97686307e980784c0fea30baea7c0e4ba5a1903\", \"storage_unittests\": \"5f7b8026d01259b8e47c56e3e2fc4540b0d6e2a9\", \"sync_integration_tests\": \"1445ead1d099e68a8473a8008d4698c619077a13\", \"telemetry_gpu_unittests\": \"433868eb8fe7cb56fdc6869922ac5e0875b1af3f\", \"telemetry_perf_unittests\": \"ec3f040a9538bb6b6435ee6677a1950073a80121\", \"telemetry_unittests\": \"76d648bcf2c2fe145d80d84846920634458c211a\", \"traffic_annotation_auditor_unittests\": \"6d83f544a4546a1f05e7bb2686609fee6683cf06\", \"ui_base_unittests\": \"5c7a9edbffbb439cabe83f21a40a441511f8671b\", \"ui_touch_selection_unittests\": \"ae9a7977a4723db261a6ed42f33af7b05f932a0c\", \"unit_tests\": \"45b438d497749e8baf4e4462b2fd88092b319119\", \"url_unittests\": \"7d78547ca9b60bdccf6994548984598359ef7e52\", \"views_perftests\": \"eb9eb04fec1ad2db35d099449e62873ae2ca63ef\", \"views_unittests\": \"8134d3cc3fb25e29801d111458f39b8fcb7e98b2\", \"viz_unittests\": \"97bbe2c86f7d582bd4391dae0828fc7bcd54a48d\", \"vr_common_unittests\": \"fc4111cea6f8c22c13af8f8060f9f51b0639879f\", \"vr_pixeltests\": \"35100901c6f441ec6b2407e188aeb021d52d529c\", \"webdriver_wpt_tests\": \"bc38722985a29a72da5677eecf565cc52689dc95\", \"weblayer_browsertests\": \"3f76a6282833c1defc020a95c407df617451b918\", \"weblayer_unittests\": \"b6d32ef0dcb33b78f720baf9f176444e9b6977af\", \"wm_unittests\": \"919dabd4c7af857b32212f289bb6103103f7527c\", \"wtf_unittests\": \"5a1fb7155de70e39e271923489b634a29fa7edb4\", \"x11_unittests\": \"25116c7c0ea18957bc4594d1f6c14b18bfd3552a\", \"xr_browser_tests\": \"6eeeb908a0c0addcd2320ea51a3135b7bb7fac47\", \"zlib_unittests\": \"fbbd2ae1c4b94767bbff3b4cfb924faef9481e81\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_25c22b29ff9525bbfd333bb12e92a9faf5d35886dc9a7dacce03d872c45df5d1_v2\", \"builder_4f840a66a98bcc23913cdceee05d6305bdb9a4a5d39b36f536d725d421d1ee25_v2\", \"builder_d6c402558de63915dde657133f192d995a5b729212ea1587a5d59fbce371e332_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_fe04a82bb3d9c756558e7f777d2f821598f573bdde1afcb57ce60c173fe87653_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-130-xu9k\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604000081054754",
"status": "COMPLETED",
"status_changed_ts": "1604003090335778",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177151",
"builder:Linux Builder (dbg)",
"buildset:commit/git/39fb9728d5cb9079a0fbf1785a03d0fe43364008",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/39fb9728d5cb9079a0fbf1785a03d0fe43364008",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030507799029959984",
"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/8865077734233546352/+/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:4f8eac550babc710",
"user_agent:luci-scheduler"
],
"updated_ts": "1604003090341747",
"url": "https://ci.chromium.org/b/8865077734233546352",
"utcnow_ts": "1604003091349814"
}
}
[20:24:51.385] Invocation finished in 50m21.218890208s with status SUCCEEDED