[20:30:36.335] New invocation is queued and will start shortly
[20:30:37.429] Starting the invocation (attempt 1)
[20:30:37.477] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:30:37.477] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:30:37.477] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9053968883665108768",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7dc18e9f41ca64b998659bbdde0c34a53e3c9343\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9053968883665108768",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/7dc18e9f41ca64b998659bbdde0c34a53e3c9343",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7dc18e9f41ca64b998659bbdde0c34a53e3c9343",
"gitiles_ref:refs/heads/master"
]
}
[20:30:38.758] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581625837656628",
"id": "8888538821612655856",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7dc18e9f41ca64b998659bbdde0c34a53e3c9343\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581625838245920",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168567",
"builder:Linux Builder (dbg)",
"buildset:commit/git/7dc18e9f41ca64b998659bbdde0c34a53e3c9343",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7dc18e9f41ca64b998659bbdde0c34a53e3c9343",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053968883665108768",
"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/8888538821612655856/+/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": "1581625838246075",
"url": "https://ci.chromium.org/b/8888538821612655856",
"utcnow_ts": "1581625838743841"
}
}
[20:30:38.758] Task URL: https://ci.chromium.org/b/8888538821612655856
[20:30:38.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:2:0) after 1m0s
[20:31:39.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:2:0)
[20:31:39.008] Timer tick, asking Buildbucket for the build status
[20:31:39.511] Build 8888538821612655856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:31:39.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:3:0) after 1m0s
[20:32:39.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:3:0)
[20:32:39.608] Timer tick, asking Buildbucket for the build status
[20:32:39.711] Build 8888538821612655856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:32:39.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:4:0) after 1m0s
[20:33:39.879] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:4:0)
[20:33:39.879] Timer tick, asking Buildbucket for the build status
[20:33:40.057] Build 8888538821612655856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:33:40.057] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:5:0) after 1m0s
[20:34:40.202] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:5:0)
[20:34:40.202] Timer tick, asking Buildbucket for the build status
[20:34:41.239] Build 8888538821612655856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:34:41.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:6:0) after 1m0s
[20:35:40.968] Received PubSub notification, asking Buildbucket for the build status
[20:35:41.529] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:41.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:6:0)
[20:35:41.823] Timer tick, asking Buildbucket for the build status
[20:35:42.030] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:42.030] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:8:0) after 1m0s
[20:36:42.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:8:0)
[20:36:42.302] Timer tick, asking Buildbucket for the build status
[20:36:43.482] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:43.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:9:0) after 1m0s
[20:37:43.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:9:0)
[20:37:43.833] Timer tick, asking Buildbucket for the build status
[20:37:43.960] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:43.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:10:0) after 1m0s
[20:38:44.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:10:0)
[20:38:44.043] Timer tick, asking Buildbucket for the build status
[20:38:44.406] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:44.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:11:0) after 1m0s
[20:39:44.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:11:0)
[20:39:44.511] Timer tick, asking Buildbucket for the build status
[20:39:44.710] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:44.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:12:0) after 1m0s
[20:40:44.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:12:0)
[20:40:44.708] Timer tick, asking Buildbucket for the build status
[20:40:46.710] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:46.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:13:0) after 1m0s
[20:41:47.557] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:13:0)
[20:41:47.557] Timer tick, asking Buildbucket for the build status
[20:41:47.711] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:47.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:14:0) after 1m0s
[20:42:48.097] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:14:0)
[20:42:48.097] Timer tick, asking Buildbucket for the build status
[20:42:48.378] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:48.378] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:15:0) after 1m0s
[20:43:48.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:15:0)
[20:43:48.795] Timer tick, asking Buildbucket for the build status
[20:43:49.115] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:49.115] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:16:0) after 1m0s
[20:44:49.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:16:0)
[20:44:49.806] Timer tick, asking Buildbucket for the build status
[20:44:50.186] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:50.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:17:0) after 1m0s
[20:45:50.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:17:0)
[20:45:50.790] Timer tick, asking Buildbucket for the build status
[20:45:52.006] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:52.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:18:0) after 1m0s
[20:46:52.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:18:0)
[20:46:52.099] Timer tick, asking Buildbucket for the build status
[20:46:52.458] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:52.458] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:19:0) after 1m0s
[20:47:52.458] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:19:0)
[20:47:52.458] Timer tick, asking Buildbucket for the build status
[20:47:52.907] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:52.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:20:0) after 1m0s
[20:48:52.973] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:20:0)
[20:48:52.973] Timer tick, asking Buildbucket for the build status
[20:48:53.564] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:53.564] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:21:0) after 1m0s
[20:49:53.603] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:21:0)
[20:49:53.603] Timer tick, asking Buildbucket for the build status
[20:49:53.772] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:53.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:22:0) after 1m0s
[20:50:53.828] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:22:0)
[20:50:53.828] Timer tick, asking Buildbucket for the build status
[20:50:53.978] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:53.978] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:23:0) after 1m0s
[20:51:54.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:23:0)
[20:51:54.056] Timer tick, asking Buildbucket for the build status
[20:51:54.279] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:54.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:24:0) after 1m0s
[20:52:54.332] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:24:0)
[20:52:54.332] Timer tick, asking Buildbucket for the build status
[20:52:54.587] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:54.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:25:0) after 1m0s
[20:53:54.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:25:0)
[20:53:54.863] Timer tick, asking Buildbucket for the build status
[20:53:55.010] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:55.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:26:0) after 1m0s
[20:54:55.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:26:0)
[20:54:55.821] Timer tick, asking Buildbucket for the build status
[20:54:56.570] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:56.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:27:0) after 1m0s
[20:55:56.653] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:27:0)
[20:55:56.653] Timer tick, asking Buildbucket for the build status
[20:55:56.819] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:56.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:28:0) after 1m0s
[20:56:56.965] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:28:0)
[20:56:56.965] Timer tick, asking Buildbucket for the build status
[20:56:57.334] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:57.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:29:0) after 1m0s
[20:57:57.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:29:0)
[20:57:57.341] Timer tick, asking Buildbucket for the build status
[20:57:57.902] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:57.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:30:0) after 1m0s
[20:58:57.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:30:0)
[20:58:57.974] Timer tick, asking Buildbucket for the build status
[20:58:58.130] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:58.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:31:0) after 1m0s
[20:59:58.195] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:31:0)
[20:59:58.195] Timer tick, asking Buildbucket for the build status
[20:59:58.905] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:58.905] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:32:0) after 1m0s
[21:00:58.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:32:0)
[21:00:58.935] Timer tick, asking Buildbucket for the build status
[21:00:59.584] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:59.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:33:0) after 1m0s
[21:01:59.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:33:0)
[21:01:59.686] Timer tick, asking Buildbucket for the build status
[21:02:00.122] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:00.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:34:0) after 1m0s
[21:03:00.172] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:34:0)
[21:03:00.172] Timer tick, asking Buildbucket for the build status
[21:03:00.453] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:00.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:35:0) after 1m0s
[21:04:00.482] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:35:0)
[21:04:00.482] Timer tick, asking Buildbucket for the build status
[21:04:00.654] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:00.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:36:0) after 1m0s
[21:05:00.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:36:0)
[21:05:00.778] Timer tick, asking Buildbucket for the build status
[21:05:00.943] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:00.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:37:0) after 1m0s
[21:06:01.009] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:37:0)
[21:06:01.009] Timer tick, asking Buildbucket for the build status
[21:06:01.321] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:01.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:38:0) after 1m0s
[21:07:01.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:38:0)
[21:07:01.406] Timer tick, asking Buildbucket for the build status
[21:07:01.576] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:01.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:39:0) after 1m0s
[21:08:01.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:39:0)
[21:08:01.596] Timer tick, asking Buildbucket for the build status
[21:08:01.754] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:01.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:40:0) after 1m0s
[21:09:01.788] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:40:0)
[21:09:01.788] Timer tick, asking Buildbucket for the build status
[21:09:02.378] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:02.378] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:41:0) after 1m0s
[21:10:02.389] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:41:0)
[21:10:02.389] Timer tick, asking Buildbucket for the build status
[21:10:02.612] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:02.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:42:0) after 1m0s
[21:11:02.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:42:0)
[21:11:02.709] Timer tick, asking Buildbucket for the build status
[21:11:02.921] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:02.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:43:0) after 1m0s
[21:12:03.016] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:43:0)
[21:12:03.016] Timer tick, asking Buildbucket for the build status
[21:12:03.308] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:03.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:44:0) after 1m0s
[21:13:03.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:44:0)
[21:13:03.338] Timer tick, asking Buildbucket for the build status
[21:13:03.692] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:03.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:45:0) after 1m0s
[21:14:03.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:45:0)
[21:14:03.853] Timer tick, asking Buildbucket for the build status
[21:14:04.007] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:04.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:46:0) after 1m0s
[21:15:04.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:46:0)
[21:15:04.072] Timer tick, asking Buildbucket for the build status
[21:15:04.271] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:04.271] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:47:0) after 1m0s
[21:16:04.470] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:47:0)
[21:16:04.470] Timer tick, asking Buildbucket for the build status
[21:16:04.662] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:04.662] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:48:0) after 1m0s
[21:17:04.773] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:48:0)
[21:17:04.773] Timer tick, asking Buildbucket for the build status
[21:17:04.921] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:04.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:49:0) after 1m0s
[21:18:05.178] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:49:0)
[21:18:05.178] Timer tick, asking Buildbucket for the build status
[21:18:05.383] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:05.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:50:0) after 1m0s
[21:19:05.660] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:50:0)
[21:19:05.660] Timer tick, asking Buildbucket for the build status
[21:19:06.143] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:06.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:51:0) after 1m0s
[21:20:06.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:51:0)
[21:20:06.364] Timer tick, asking Buildbucket for the build status
[21:20:06.999] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:06.999] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:52:0) after 1m0s
[21:21:07.176] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:52:0)
[21:21:07.176] Timer tick, asking Buildbucket for the build status
[21:21:07.492] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:07.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:53:0) after 1m0s
[21:22:07.584] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:53:0)
[21:22:07.584] Timer tick, asking Buildbucket for the build status
[21:22:08.106] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:08.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:54:0) after 1m0s
[21:23:08.180] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:54:0)
[21:23:08.180] Timer tick, asking Buildbucket for the build status
[21:23:08.484] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:08.484] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:55:0) after 1m0s
[21:24:08.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:55:0)
[21:24:08.650] Timer tick, asking Buildbucket for the build status
[21:24:09.115] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:09.115] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:56:0) after 1m0s
[21:25:09.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:56:0)
[21:25:09.187] Timer tick, asking Buildbucket for the build status
[21:25:09.382] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:09.382] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:57:0) after 1m0s
[21:26:09.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:57:0)
[21:26:09.372] Timer tick, asking Buildbucket for the build status
[21:26:09.790] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:09.790] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:58:0) after 1m0s
[21:27:09.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:58:0)
[21:27:09.860] Timer tick, asking Buildbucket for the build status
[21:27:10.098] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:10.098] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:59:0) after 1m0s
[21:28:10.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:59:0)
[21:28:10.129] Timer tick, asking Buildbucket for the build status
[21:28:10.761] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:10.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:60:0) after 1m0s
[21:29:10.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:60:0)
[21:29:10.863] Timer tick, asking Buildbucket for the build status
[21:29:11.772] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:11.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:61:0) after 1m0s
[21:30:11.770] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:61:0)
[21:30:11.770] Timer tick, asking Buildbucket for the build status
[21:30:13.114] Build 8888538821612655856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:13.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053968883665108768:62:0) after 1m0s
[21:30:54.662] Received PubSub notification, asking Buildbucket for the build status
[21:30:54.844] Build 8888538821612655856: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:30:54.844] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581629426896695",
"created_by": "project:chromium",
"created_ts": "1581625837656628",
"id": "8888538821612655856",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7dc18e9f41ca64b998659bbdde0c34a53e3c9343\"}}",
"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-40-rest\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168567, \"got_angle_revision\": \"b79b57e047bb24af9e40ed0e5b310af75f0705d8\", \"got_dawn_revision\": \"2fd618192985122aafb494ac5e9a39f572ef46fc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"7dc18e9f41ca64b998659bbdde0c34a53e3c9343\", \"got_revision_cp\": \"refs/heads/master@{#741180}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"503b21fd3203c7b9607ef3583a0fe32784d5f877\", \"got_v8_revision\": \"0bee77f5f81e2e11a26aa7ca4b5a22dffc5120ba\", \"got_v8_revision_cp\": \"refs/heads/8.2.71@{#1}\", \"got_webrtc_revision\": \"b28e57e72580b0269cecf91754b4c3a1937e0712\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30511}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7dc18e9f41ca64b998659bbdde0c34a53e3c9343\", \"swarm_hashes_refs/heads/master(at){#741180}_without_patch\": {\"accessibility_unittests\": \"3b4086d5d9be79e79cce4d9f659d998ad571c82b\", \"angle_unittests\": \"348803e9c863d2b659e4ef223c270b6053b8656f\", \"app_shell_unittests\": \"c51d5b00ad9b89ad8980bd154d96516c0b908284\", \"aura_unittests\": \"09b71e5113e531ecba565449349f367d4656610d\", \"base_unittests\": \"6c2f87ecd36e4e853d2d236f6abe0ff75c7b6ed6\", \"base_util_unittests\": \"21cd0e946cf4d6f7177b1bb2107d147d5b5ab73f\", \"blink_common_unittests\": \"da2b4a810d5e014972df62de569b2b25cc2b92af\", \"blink_fuzzer_unittests\": \"2d7be7a7f2d1cde49a20ac522b35dfb004cb827f\", \"blink_heap_unittests\": \"017f3915e83eb66444f668a966de61be43badf3f\", \"blink_platform_unittests\": \"f5aa46309b165626d82053cf715ea2b9c921c780\", \"blink_python_tests\": \"69b2edc78c1504c24bc8a30e35c542761ccd1e3e\", \"blink_unittests\": \"5145cf1dfb3357e425afab6f64cac5cb6de9b051\", \"blink_web_tests\": \"3207ccc1d078e39be1f2649ddd3818df7fe7dbdd\", \"boringssl_crypto_tests\": \"ec25072896452812b72798b95f2700d80c833475\", \"boringssl_ssl_tests\": \"46db2c0e1d853b40fede799aa28babddf9596d18\", \"browser_tests\": \"cbb97d215794ce6ddc578382d4cfb25bc3004d8a\", \"cacheinvalidation_unittests\": \"2891d9acf005b9b3fd4f41bc909d49790e49f060\", \"capture_unittests\": \"9d827b47794b0b362cc755421ba6408d07fab156\", \"cast_unittests\": \"a755966111d8f09d735ae8cc170eae5aa845563d\", \"cc_unittests\": \"98e1f9cc492b711e85500cdcd97dd26c50dabaa0\", \"chrome_app_unittests\": \"1771a712f4a726a3ba7bfe98216af6a422ad75d0\", \"chromedriver_unittests\": \"fb0289ad06d9f66ac7cf31b4fdad49052fe5f82b\", \"components_browsertests\": \"d2f812c95ce6818482737a8d2edd4cef840a62cb\", \"components_unittests\": \"45bd658f79bbf7efe0d0c80d41eab27d41b6951d\", \"compositor_unittests\": \"7d209b28950ff2c99ef7756548819883d71f22d9\", \"content_browsertests\": \"bcbb85e06746cf2c3651f9315ff7426010454e06\", \"content_shell_crash_test\": \"5fea0bff6bd54f482f2c24027311efeb5f037442\", \"content_unittests\": \"7bb3ab6f6ae3e0aff69ea2e82702c1efdbe77716\", \"crashpad_tests\": \"61f59444e22f9f22741e95996521b035abea8ea4\", \"cronet_tests\": \"156ed8db4fcc19c98eeb6f0916848479f87d3d68\", \"cronet_unittests\": \"84a99137ce94c9d3a4314eaa437a32792cf53933\", \"crypto_unittests\": \"0f41450b7cac87f87d9b52ea3c0fd00806c82469\", \"dbus_unittests\": \"f7baaf9ff88c33b6fbfdb9c743e9f946c4b3438d\", \"device_unittests\": \"36a263f20b04e7aa102ec06b4127c42b2ec8f021\", \"display_unittests\": \"8a36f81acb43c8a4babdbbaea96b9b88bac4eece\", \"events_unittests\": \"d0956a2c5f1d31069e7afcde9dea9c5432178f0f\", \"extensions_browsertests\": \"4159a6710b28f5c6640caecea1ffd44651592a3d\", \"extensions_unittests\": \"a3fa29082740e1b20751f2cb1952708e3772f30a\", \"filesystem_service_unittests\": \"76a56e66839cca114ea27307248354bf90781061\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"fa3515fecb0d0c4af9fe24598937e95f63ae6f3d\", \"gfx_unittests\": \"93542fcb972a4ad454c99a5f42fa73210169ea27\", \"gin_unittests\": \"bbd437efe56b180696d6bf2ffd965af6678298cc\", \"google_apis_unittests\": \"fdb8f50f2d577615bf8e645d5cf57b39da8380eb\", \"gpu_unittests\": \"83459bf340854fbe15afe01eec1bf81e2ea0a0fe\", \"grit_python_unittests\": \"07488c096d20bb2a4e6d9280813fca6afbee6dc0\", \"gwp_asan_unittests\": \"097e2b0db57c270ad56854b2d56081b4db7332f5\", \"headless_browsertests\": \"23f40362a774a99c5e62f70482534d3b8756c45f\", \"headless_unittests\": \"a18bbbea6955313304be2adc1c138493f92c6fab\", \"interactive_ui_tests\": \"62e4b298e4db190d70717c17ecef6fd103c0441d\", \"ipc_tests\": \"dd6ae43f45f119573d502279043665a783fa40d6\", \"jingle_unittests\": \"0bb4b2dfa329c2d67133b34805566bb5639f9465\", \"latency_unittests\": \"11cc8b71642f95f3b8deb661cfeff041b41489d8\", \"libjingle_xmpp_unittests\": \"2f5c45cc68e71a0460000cfcc2c2fd497b492db6\", \"media_blink_unittests\": \"a67f9fe5bec926b4c1fea0c5fdd5a059a20d79ee\", \"media_service_unittests\": \"4349b84ff66737a9c54c461cc65998853b0a1572\", \"media_unittests\": \"2be33da5841dc8fe48828c8bd8269d3a5f1f51e5\", \"message_center_unittests\": \"12709b12af88b087f18835c072f91b196344a36d\", \"metrics_python_tests\": \"dc44c15d1496427be0b7048c7de698a62c24eaa7\", \"midi_unittests\": \"64a98c94f6d7503c8780781cf65362ba0b7af3eb\", \"mojo_core_unittests\": \"33f533d093d13ecd2fecae324b04a6f019a7bf05\", \"mojo_unittests\": \"54185d30ed6c97843c8332d47d6f77f444727378\", \"nacl_helper_nonsfi_unittests\": \"b516ec31c286d1bdbaab96cddc9b34d662505757\", \"nacl_loader_unittests\": \"d4a9d41298496bdc8e47906c16939f9c481a393c\", \"native_theme_unittests\": \"7d5590b62978bcb7ff9185513e86b7e59d2476b9\", \"net_unittests\": \"6ba791a5412a9b1259b9fe4d1dd6ace27a8dc326\", \"pdf_unittests\": \"661565baca26d3f10c780e46a84ed62b9497366f\", \"perfetto_unittests\": \"7e9c345cb54285d97b1d3dffd1e9b0fe2c3b39e7\", \"ppapi_unittests\": \"a42a55cec24d082d583fbd4bdd410142cba7d1fe\", \"printing_unittests\": \"4bb6dfb5fb13f0c26827b9183c0b5c8fb560b653\", \"remoting_unittests\": \"8b666ac59af955a0937e2b1ffeee3151fb3ed60a\", \"sandbox_linux_unittests\": \"ff8c79717c11d4bc6c086468e0c69e22462f4255\", \"service_manager_unittests\": \"58ce8b9f5c47c3e532432e7e34eb20f98a2f5b0e\", \"services_unittests\": \"fba8ab7647b22313d46a6e4b4cc4ae33bec5a855\", \"shell_dialogs_unittests\": \"369891f5ce1f4dc42178709617dc2bee2bb6cbd0\", \"skia_unittests\": \"53b9feb13d7cee26640212600228c65ce282edb9\", \"snapshot_unittests\": \"82a294983f9bc261a41ea2c01b48eb838a6d350e\", \"sql_unittests\": \"fcc63aaedb1efba0300332aa41dcc69aaab4650b\", \"storage_unittests\": \"63d57814a69949ce91e13c71253af7c1526b0ae1\", \"sync_integration_tests\": \"b5b19d05712110f97990fe8f9a3e9f1e455f8392\", \"telemetry_gpu_unittests\": \"b2e16562c3d85896fa66c11dbdcf18444e259ada\", \"telemetry_perf_unittests\": \"11247319eedae73a92a5b532266c8ec0a89a2ceb\", \"telemetry_unittests\": \"3a1e065d57d2831cd6e5a9b050143409b46645b7\", \"traffic_annotation_auditor_unittests\": \"f1ef76a7fb992fa46ee271df18247b0e0fb1e431\", \"ui_base_unittests\": \"b35b50402e1816b6614e9482419d433b60f99c3e\", \"ui_touch_selection_unittests\": \"6d761d5881492089e89f8d3ca3754507cc8b7d21\", \"unit_tests\": \"462eab91a1b3ea0254eb3c66a5d7b61688c40c6d\", \"url_unittests\": \"af85fd1e30f2a88670fa26864490532a9e0bc5df\", \"views_perftests\": \"f1706a25a3dde37c5f808bfa13105c9f613f1ec9\", \"views_unittests\": \"250663b82a407d2b126d94229c643e45b7245b0a\", \"viz_unittests\": \"c1fb3d319a89dbe9248180222fab7987e902d760\", \"vr_common_unittests\": \"46640c572e1e3bc2fcde87039a10b14f2c5d158f\", \"vr_pixeltests\": \"f2751d68f0f3b1ef191b20b25684c2a9c3c3ad59\", \"webdriver_wpt_tests\": \"e221f75d60f18d6408cf52e58bfbb32068aa1c64\", \"weblayer_browsertests\": \"756688dcd33b8227488e929fbbf7210de156e645\", \"wm_unittests\": \"9320270e9052ab76c553a1284a7862f5653d78b9\", \"wtf_unittests\": \"a4c479d3894529ddaa67064dd0f305ed42f8e76d\", \"xr_browser_tests\": \"7d4372f2037ceabb3f23fbe1604d923f7555c85d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0442f466ee54a95cfb510061921bb277cbb8d5a6f79e09e045baf9198c2b257e_v2\", \"builder_91dc5ce0f7d9a4ba8efbdbb6360d947a001f2754e92adddaf9400582bbdcce50_v2\", \"builder_957c0f1a1c74c3ada6665996f2ff614223d5da32e2cc2316ff7cc4c9c4beae5c_v2\", \"builder_9a2f1f8988f1f66ad7e537b613a307edd4200b924c9c36d38f851454b2c5979c_v2\", \"builder_e4464922e5c60bddfcc3d01cfc511ef7f4a711bded636fa98c66f03a573264ee_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-40-rest\"], \"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\": [\"4815-21a95a1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581626107837235",
"status": "COMPLETED",
"status_changed_ts": "1581629453727806",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168567",
"builder:Linux Builder (dbg)",
"buildset:commit/git/7dc18e9f41ca64b998659bbdde0c34a53e3c9343",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7dc18e9f41ca64b998659bbdde0c34a53e3c9343",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053968883665108768",
"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/8888538821612655856/+/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:4a591094cb22c210",
"user_agent:luci-scheduler"
],
"updated_ts": "1581629453732822",
"url": "https://ci.chromium.org/b/8888538821612655856",
"utcnow_ts": "1581629454826042"
}
}
[21:30:54.844] Invocation finished in 1h0m18.52901973s with status SUCCEEDED