[02:44:58.126] New invocation is queued and will start shortly
[02:44:59.306] Starting the invocation (attempt 1)
[02:44:59.345] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:44:59.345] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:44:59.346] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9049687273362680592",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4898ea485f5eb1d2c1c292c636f4ab5c87edabc5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9049687273362680592",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/4898ea485f5eb1d2c1c292c636f4ab5c87edabc5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4898ea485f5eb1d2c1c292c636f4ab5c87edabc5",
"gitiles_ref:refs/heads/master"
]
}
[02:45:01.376] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1585709099458140",
"id": "8884257211284527216",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4898ea485f5eb1d2c1c292c636f4ab5c87edabc5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585709100883182",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170466",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4898ea485f5eb1d2c1c292c636f4ab5c87edabc5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4898ea485f5eb1d2c1c292c636f4ab5c87edabc5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9049687273362680592",
"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/8884257211284527216/+/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": "1585709100883335",
"url": "https://ci.chromium.org/b/8884257211284527216",
"utcnow_ts": "1585709101292223"
}
}
[02:45:01.376] Task URL: https://ci.chromium.org/b/8884257211284527216
[02:45:01.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:2:0) after 1m0s
[02:46:01.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:2:0)
[02:46:01.450] Timer tick, asking Buildbucket for the build status
[02:46:01.768] Build 8884257211284527216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:01.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:3:0) after 1m0s
[02:47:01.789] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:3:0)
[02:47:01.789] Timer tick, asking Buildbucket for the build status
[02:47:02.183] Build 8884257211284527216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:02.183] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:4:0) after 1m0s
[02:48:02.239] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:4:0)
[02:48:02.239] Timer tick, asking Buildbucket for the build status
[02:48:02.459] Build 8884257211284527216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:02.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:5:0) after 1m0s
[02:49:02.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:5:0)
[02:49:02.551] Timer tick, asking Buildbucket for the build status
[02:49:02.803] Build 8884257211284527216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:02.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:6:0) after 1m0s
[02:49:08.451] Received PubSub notification, asking Buildbucket for the build status
[02:49:08.604] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:02.898] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:6:0)
[02:50:02.898] Timer tick, asking Buildbucket for the build status
[02:50:03.276] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:03.276] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:8:0) after 1m0s
[02:51:03.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:8:0)
[02:51:03.304] Timer tick, asking Buildbucket for the build status
[02:51:03.427] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:03.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:9:0) after 1m0s
[02:52:03.491] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:9:0)
[02:52:03.491] Timer tick, asking Buildbucket for the build status
[02:52:03.625] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:03.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:10:0) after 1m0s
[02:53:03.680] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:10:0)
[02:53:03.680] Timer tick, asking Buildbucket for the build status
[02:53:03.865] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:03.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:11:0) after 1m0s
[02:54:03.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:11:0)
[02:54:03.889] Timer tick, asking Buildbucket for the build status
[02:54:04.041] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:04.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:12:0) after 1m0s
[02:55:04.016] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:12:0)
[02:55:04.016] Timer tick, asking Buildbucket for the build status
[02:55:04.979] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:04.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:13:0) after 1m0s
[02:56:05.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:13:0)
[02:56:05.048] Timer tick, asking Buildbucket for the build status
[02:56:05.192] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:05.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:14:0) after 1m0s
[02:57:05.214] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:14:0)
[02:57:05.214] Timer tick, asking Buildbucket for the build status
[02:57:05.406] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:05.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:15:0) after 1m0s
[02:58:05.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:15:0)
[02:58:05.423] Timer tick, asking Buildbucket for the build status
[02:58:05.646] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:05.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:16:0) after 1m0s
[02:59:05.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:16:0)
[02:59:05.677] Timer tick, asking Buildbucket for the build status
[02:59:05.825] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:05.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:17:0) after 1m0s
[03:00:05.867] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:17:0)
[03:00:05.867] Timer tick, asking Buildbucket for the build status
[03:00:06.166] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:06.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:18:0) after 1m0s
[03:01:06.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:18:0)
[03:01:06.192] Timer tick, asking Buildbucket for the build status
[03:01:06.681] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:06.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:19:0) after 1m0s
[03:02:06.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:19:0)
[03:02:06.701] Timer tick, asking Buildbucket for the build status
[03:02:06.918] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:06.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:20:0) after 1m0s
[03:03:38.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:20:0)
[03:03:38.859] Timer tick, asking Buildbucket for the build status
[03:03:42.536] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:42.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:21:0) after 1m0s
[03:04:42.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:21:0)
[03:04:42.626] Timer tick, asking Buildbucket for the build status
[03:04:42.864] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:42.864] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:22:0) after 1m0s
[03:05:42.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:22:0)
[03:05:42.944] Timer tick, asking Buildbucket for the build status
[03:05:43.037] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:43.037] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:23:0) after 1m0s
[03:06:43.140] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:23:0)
[03:06:43.140] Timer tick, asking Buildbucket for the build status
[03:06:43.339] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:43.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:24:0) after 1m0s
[03:07:43.411] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:24:0)
[03:07:43.411] Timer tick, asking Buildbucket for the build status
[03:07:43.661] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:43.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:25:0) after 1m0s
[03:08:43.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:25:0)
[03:08:43.691] Timer tick, asking Buildbucket for the build status
[03:08:43.869] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:43.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:26:0) after 1m0s
[03:09:43.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:26:0)
[03:09:43.942] Timer tick, asking Buildbucket for the build status
[03:09:44.102] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:44.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:27:0) after 1m0s
[03:10:44.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:27:0)
[03:10:44.121] Timer tick, asking Buildbucket for the build status
[03:10:44.733] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:44.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:28:0) after 1m0s
[03:11:44.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:28:0)
[03:11:44.839] Timer tick, asking Buildbucket for the build status
[03:11:44.979] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:44.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:29:0) after 1m0s
[03:12:45.051] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:29:0)
[03:12:45.051] Timer tick, asking Buildbucket for the build status
[03:12:45.375] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:45.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:30:0) after 1m0s
[03:13:45.476] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:30:0)
[03:13:45.476] Timer tick, asking Buildbucket for the build status
[03:13:46.407] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:46.407] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:31:0) after 1m0s
[03:14:46.439] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:31:0)
[03:14:46.439] Timer tick, asking Buildbucket for the build status
[03:14:46.623] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:46.623] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:32:0) after 1m0s
[03:15:46.647] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:32:0)
[03:15:46.647] Timer tick, asking Buildbucket for the build status
[03:15:46.867] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:46.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:33:0) after 1m0s
[03:16:46.892] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:33:0)
[03:16:46.892] Timer tick, asking Buildbucket for the build status
[03:16:47.098] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:47.098] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:34:0) after 1m0s
[03:17:47.135] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:34:0)
[03:17:47.135] Timer tick, asking Buildbucket for the build status
[03:17:47.560] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:47.560] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:35:0) after 1m0s
[03:18:47.579] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:35:0)
[03:18:47.579] Timer tick, asking Buildbucket for the build status
[03:18:47.944] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:47.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:36:0) after 1m0s
[03:19:47.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:36:0)
[03:19:47.968] Timer tick, asking Buildbucket for the build status
[03:19:48.224] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:48.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:37:0) after 1m0s
[03:20:48.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:37:0)
[03:20:48.241] Timer tick, asking Buildbucket for the build status
[03:20:48.365] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:48.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:38:0) after 1m0s
[03:21:48.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:38:0)
[03:21:48.381] Timer tick, asking Buildbucket for the build status
[03:21:48.513] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:48.514] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:39:0) after 1m0s
[03:22:48.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:39:0)
[03:22:48.578] Timer tick, asking Buildbucket for the build status
[03:22:48.721] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:48.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:40:0) after 1m0s
[03:23:48.725] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:40:0)
[03:23:48.725] Timer tick, asking Buildbucket for the build status
[03:23:48.876] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:48.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:41:0) after 1m0s
[03:24:48.898] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:41:0)
[03:24:48.898] Timer tick, asking Buildbucket for the build status
[03:24:49.034] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:49.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:42:0) after 1m0s
[03:25:49.069] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:42:0)
[03:25:49.069] Timer tick, asking Buildbucket for the build status
[03:25:49.474] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:49.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:43:0) after 1m0s
[03:26:49.494] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:43:0)
[03:26:49.494] Timer tick, asking Buildbucket for the build status
[03:26:49.813] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:49.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:44:0) after 1m0s
[03:27:49.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:44:0)
[03:27:49.824] Timer tick, asking Buildbucket for the build status
[03:27:50.383] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:50.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:45:0) after 1m0s
[03:28:50.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:45:0)
[03:28:50.417] Timer tick, asking Buildbucket for the build status
[03:28:51.113] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:51.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:46:0) after 1m0s
[03:29:51.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:46:0)
[03:29:51.205] Timer tick, asking Buildbucket for the build status
[03:29:51.354] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:51.354] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:47:0) after 1m0s
[03:30:51.411] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:47:0)
[03:30:51.411] Timer tick, asking Buildbucket for the build status
[03:30:52.724] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:52.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:48:0) after 1m0s
[03:31:52.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:48:0)
[03:31:52.749] Timer tick, asking Buildbucket for the build status
[03:31:53.066] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:53.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:49:0) after 1m0s
[03:32:53.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:49:0)
[03:32:53.105] Timer tick, asking Buildbucket for the build status
[03:32:53.438] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:53.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:50:0) after 1m0s
[03:33:53.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:50:0)
[03:33:53.460] Timer tick, asking Buildbucket for the build status
[03:33:53.647] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:53.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:51:0) after 1m0s
[03:34:53.678] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:51:0)
[03:34:53.678] Timer tick, asking Buildbucket for the build status
[03:34:54.768] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:54.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:52:0) after 1m0s
[03:35:54.772] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:52:0)
[03:35:54.772] Timer tick, asking Buildbucket for the build status
[03:35:55.073] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:55.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:53:0) after 1m0s
[03:36:55.133] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:53:0)
[03:36:55.133] Timer tick, asking Buildbucket for the build status
[03:36:55.427] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:55.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:54:0) after 1m0s
[03:37:55.456] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:54:0)
[03:37:55.456] Timer tick, asking Buildbucket for the build status
[03:37:55.684] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:55.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:55:0) after 1m0s
[03:38:55.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:55:0)
[03:38:55.727] Timer tick, asking Buildbucket for the build status
[03:38:56.322] Build 8884257211284527216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:56.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049687273362680592:56:0) after 1m0s
[03:39:10.424] Received PubSub notification, asking Buildbucket for the build status
[03:39:10.525] Build 8884257211284527216: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:39:10.525] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1585712349062133",
"created_by": "project:chromium",
"created_ts": "1585709099458140",
"id": "8884257211284527216",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4898ea485f5eb1d2c1c292c636f4ab5c87edabc5\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$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-central1-b-8-135-rv5w\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 170466, \"got_angle_revision\": \"4b94d7bb4fbed9018d198dfdc50c3aa5f9be3ddf\", \"got_dawn_revision\": \"3da19b843ffd63d884f3a67f2da3eea20818499a\", \"got_nacl_revision\": \"ebf11aaad97fde7f91b1c72e0dddaf1653d41f77\", \"got_revision\": \"4898ea485f5eb1d2c1c292c636f4ab5c87edabc5\", \"got_revision_cp\": \"refs/heads/master@{#755219}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"5cf1e9a31c90ccd9ec40d0c5ef1357f6e0ec1cfd\", \"got_v8_revision\": \"1668abddd8147c49c8f2f90b78dc2701f3794a30\", \"got_v8_revision_cp\": \"refs/heads/8.3.110@{#1}\", \"got_webrtc_revision\": \"65674d83e1f59c2233a26987916caed81cee62f5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30952}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4898ea485f5eb1d2c1c292c636f4ab5c87edabc5\", \"swarm_hashes_refs/heads/master(at){#755219}_without_patch\": {\"accessibility_unittests\": \"e28ed0018c179c606379f58b05288b02e14cbfca\", \"angle_unittests\": \"5063d5a6aafeee2a449c58d1125d94e8f68fc0c2\", \"app_shell_unittests\": \"cd8b81b25e3e859e46cd41bae6157a205127b493\", \"aura_unittests\": \"e666f5f5c8de41e69cbd032bcc527331789c8ddd\", \"base_unittests\": \"a3642d9b389d92108171036f1eb2ad37eb11de24\", \"base_util_unittests\": \"064abcd23d791775ee2bbf9d32a1cda8cc91c3dc\", \"blink_common_unittests\": \"52486150ab0d5bfad876524e10152645c8d621fc\", \"blink_fuzzer_unittests\": \"37fff935cb04febabbce244336cda3847f97e9e1\", \"blink_heap_unittests\": \"a1eee094ad5797ec9857624383bf49883358b8ae\", \"blink_platform_unittests\": \"e405a31866e4e5c2ce91a09060fa793c5033b5bd\", \"blink_python_tests\": \"3c87e81c34afaf1a7bfe0c8f6d4dd08560555ff1\", \"blink_unittests\": \"e520e2b40d7c6dae073406c51cac7e1182b5bfc4\", \"blink_web_tests\": \"c6a8d388ff503d002e32a27163558d5580d18868\", \"boringssl_crypto_tests\": \"b53ef80a7ced43800b34c942aca1059889b35fcc\", \"boringssl_ssl_tests\": \"6a56744374c748562234cfa1750fd131ad2607ec\", \"browser_tests\": \"b255b6c52d30a28a4ab7861526ac2f1cb959d922\", \"cacheinvalidation_unittests\": \"2a06e20316d5a1fd57115fff692d8ba3d8655937\", \"capture_unittests\": \"1cad66a4e0b37237768cb2d04bc7c2b4c6735769\", \"cast_unittests\": \"d3fee538b6491abacfb0438995eebb40c67bdc46\", \"cc_unittests\": \"5ddee04228b531080c85bcfcb7582876535a31f6\", \"chrome_app_unittests\": \"63d9371116237b05048677e0527fe6f947ea1db4\", \"chromedriver_unittests\": \"326b5404a75278eec72b250c1bec749ee426b015\", \"components_browsertests\": \"c05a2f5fc6277453019d865446a216576adf3ace\", \"components_unittests\": \"898c5a60104f5f75f353d6fa1c2f345580b164e2\", \"compositor_unittests\": \"24327f959acc8b4f7b41d276209dbaf4ea7989c5\", \"content_browsertests\": \"66d4435d0615d19e9b8ff2fe714b0016598bb964\", \"content_shell_crash_test\": \"17ad912c95a18edd84b9d24c4934326224329002\", \"content_unittests\": \"ed469b8691a9393368a361c6d645d7d7a1869f3f\", \"crashpad_tests\": \"6a11c237295a4f5a822edb1149de5c23b2d41d5d\", \"cronet_tests\": \"d5144ff6fbc508c68490242e02572c4b1f692e50\", \"cronet_unittests\": \"863384512d702aa8c81c3d9efbf8a13b91b02db7\", \"crypto_unittests\": \"59dc6631527404166d8f7e3b0055c13b7ee9ba0e\", \"dbus_unittests\": \"bc626c42aa8b79f69b80a684212b331475e4536d\", \"device_unittests\": \"36b3b0ada30f06d255b5a282a5cbdcbd006532e3\", \"display_unittests\": \"0475cffb10c7f30333be818a7cd63f641cc8fa35\", \"events_unittests\": \"62714eb5fbcbb3ebc5788d060e0e4149d345827f\", \"extensions_browsertests\": \"24868f511e68ae7acd660bd607bd54e2a4a140cd\", \"extensions_unittests\": \"63c496140e76b40d779b80e0ff9339d0e5c0f15a\", \"filesystem_service_unittests\": \"127168b5c6b63572c4adc3201d03ef2d0934f7f0\", \"flatbuffers_unittests\": \"72ac4f314db80fab790f3135fe10fde26e7da08e\", \"gcm_unit_tests\": \"14d2d301380048fd325be85ac04b6f23b01bb76e\", \"gfx_unittests\": \"b9cf89ec9a75374172aeb9f67096b728b0d23d98\", \"gin_unittests\": \"ce7c89447a1da52d80837593de6b85eb49df2916\", \"google_apis_unittests\": \"55603160f35e709360dd2ce2f30a2350b8cb0e1e\", \"gpu_unittests\": \"11cafaebd3146c31bbdf7a6214f431ba9387aa73\", \"grit_python_unittests\": \"8c3aba08684a4851b7eb5e55316c1cdda2ef1701\", \"gwp_asan_unittests\": \"73e856c4c4e972512fcd2fee04dbbea2cc9ac227\", \"headless_browsertests\": \"da1ac52d6b2e768a1d97cd5b1e340c960e4475da\", \"headless_unittests\": \"cdc7aaa3116df43cdee5a238b4497edf1720be63\", \"interactive_ui_tests\": \"9ecdf48943f5fa21fcc494c55e2cc9faef97339e\", \"ipc_tests\": \"b0956db00c4788c9bc5293e1f9fdca3e8b5e2499\", \"jingle_unittests\": \"469ef812346bcea953e1abdf53ed83592d61f281\", \"latency_unittests\": \"2e5b005be50d8e9b15437bf320b8e97c653e4ee8\", \"libjingle_xmpp_unittests\": \"a0dd5e347ab668b0bc98f2629865fcec6d99348e\", \"media_blink_unittests\": \"f4bb48b81dd1ce3d19510f1e9f7c78edbbe4ceea\", \"media_unittests\": \"4955f610b32adff881d9efb59fe4d76640823aa2\", \"message_center_unittests\": \"f45270d7ba1cbae209ca8e1a84343f1b908134bf\", \"metrics_python_tests\": \"2a988a75cb23f14d47a02b0c046831708d07f423\", \"midi_unittests\": \"225beed46be8eccdd1325315250af6534acda065\", \"mojo_core_unittests\": \"a213d1e46de01cb4ea71225002d7e2905379216d\", \"mojo_unittests\": \"f667310afbe517047d81fb3ca48c8d7755c158f5\", \"nacl_helper_nonsfi_unittests\": \"5f2c609da47e1006c5639a67fb5d8210763e47ed\", \"nacl_loader_unittests\": \"a40886b4358a8d555b2ade823afa54d06ef4a490\", \"native_theme_unittests\": \"7814bc71e2aca38b56966db0fcdca8040ce15a74\", \"net_unittests\": \"736321f15d374596ade32a9f2ecfac276ceaf214\", \"pdf_unittests\": \"6094c720711034b00049c2b0159d1cbd7c1e8338\", \"perfetto_unittests\": \"852b1680e63076f5cdb27e36053ced47572fbe53\", \"ppapi_unittests\": \"1c0931552a4f161158cb06808851a932f8824177\", \"printing_unittests\": \"317aa6e69662e5407ca4a858cbc1616154626147\", \"remoting_unittests\": \"088b264a0486812a0ffd6a0c02a137bc8bbbbdd4\", \"sandbox_linux_unittests\": \"fc24d6748c18a78e760832cf27477970fcb11035\", \"service_manager_unittests\": \"0ed99180d582547938b588807f6ea53f12f3c950\", \"services_unittests\": \"ca9b779fb282659a74a121b5356eaf18b1db17b4\", \"shell_dialogs_unittests\": \"1167eaf76fa02eb54fddf2e1341c618a48a4dfff\", \"skia_unittests\": \"6a89bf6c581f9018b3465ac0e0ce5a417addc153\", \"snapshot_unittests\": \"dc99833ecd555d52f65074c67769a49ab101d7b6\", \"sql_unittests\": \"18dbb1e4fb600b42d5720ff539298e8abcf08053\", \"storage_unittests\": \"e9d8775173e8ade032cb557f21c95dc5b94f777f\", \"sync_integration_tests\": \"c3e7f45d82b67ab13f3742075021a79251aa74ac\", \"telemetry_gpu_unittests\": \"ba5b9e2c9f7cd5a29bdc14d7ffa021dda93865e8\", \"telemetry_perf_unittests\": \"e6c044754aeffa2a6c49e8d5565b249fa25c7784\", \"telemetry_unittests\": \"55e38066cf42007210a6bf858ce415c6ba17e826\", \"traffic_annotation_auditor_unittests\": \"32c4021b8cd9cc5fcedb1b1176d5972555dd89d4\", \"ui_base_unittests\": \"ddb5bb37527ac22df0c47b8087e95cf2f96b1bff\", \"ui_touch_selection_unittests\": \"f240ad0f144c6ee7c23253607dc75f9a03c9bdea\", \"unit_tests\": \"fb79e1468dd4831857952842300bb752d0820439\", \"url_unittests\": \"8b4febbe00821c26e614f6dd4ba5d9ca49fdbe2e\", \"views_perftests\": \"3af1463f2edef5bab02fc364ef25a22d75f116c2\", \"views_unittests\": \"cbcead1541c34f797b817a07128e53d746df7357\", \"viz_unittests\": \"c0c6dc48ff27a662aafd151317547b8026fdf399\", \"vr_common_unittests\": \"46e9d55bcb136bc4991c76537f9939fb4bf11363\", \"vr_pixeltests\": \"a645f9d779e46980047509b1681298f5b7f8acce\", \"webdriver_wpt_tests\": \"e299ce4298c3b697fae41cc122848dc8da8328ff\", \"weblayer_browsertests\": \"f17f61400ce3d0b335ed31899b1e2c92ab95e3f2\", \"wm_unittests\": \"faecacd3460f31cbd61a8ba78c0aadcdb66350b3\", \"wtf_unittests\": \"7c2942eb41466e84c1ef5e2603342dd852eeed52\", \"xr_browser_tests\": \"4a02f5f841060145fe6fe5a0b8be7e110ea675ce\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_36472ddafb4960b563fa0dfd4883d4c097bf9805cea97d60ada20c6be0c80514_v2\", \"builder_609b54f795c46f6da98bce3e3c3edeb2c2e2d72c7759cc5040a86edccd734c7c_v2\", \"builder_6e17dc7623fba43c9632527d18d71e4843b504e37694b559b7b91daecd01d18c_v2\", \"builder_86caf262f74ae694bec00fbb86541daa2df96eb35c1a4d9a06c3c1dcd129237e_v2\", \"builder_875b3d09c056bd526120073ee92829bff53ff18ee7d820cb329ea9d6d72bffe1_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-135-rv5w\"], \"image\": [\"chrome-xenial-20032700-43453ad22a9\"], \"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\": [\"4916-b2318d4\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585709347418403",
"status": "COMPLETED",
"status_changed_ts": "1585712349805640",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170466",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4898ea485f5eb1d2c1c292c636f4ab5c87edabc5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4898ea485f5eb1d2c1c292c636f4ab5c87edabc5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9049687273362680592",
"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/8884257211284527216/+/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:4b4c7239f4251710",
"user_agent:luci-scheduler"
],
"updated_ts": "1585712349811039",
"url": "https://ci.chromium.org/b/8884257211284527216",
"utcnow_ts": "1585712350508695"
}
}
[03:39:10.525] Invocation finished in 54m12.432217383s with status SUCCEEDED