[21:40:56.277] New invocation is queued and will start shortly
[21:40:57.554] Starting the invocation (attempt 1)
[21:40:57.592] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:40:57.592] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:40:57.592] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9032311783761652400",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"15b71141882153c6434ab8858b8d017151e2003e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9032311783761652400",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/15b71141882153c6434ab8858b8d017151e2003e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/15b71141882153c6434ab8858b8d017151e2003e",
"gitiles_ref:refs/heads/master"
]
}
[21:40:58.777] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602279657707099",
"id": "8866881721598458832",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"15b71141882153c6434ab8858b8d017151e2003e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602279658437279",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176507",
"builder:Linux Builder (dbg)",
"buildset:commit/git/15b71141882153c6434ab8858b8d017151e2003e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/15b71141882153c6434ab8858b8d017151e2003e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032311783761652400",
"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/8866881721598458832/+/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": "1602279658437394",
"url": "https://ci.chromium.org/b/8866881721598458832",
"utcnow_ts": "1602279658732170"
}
}
[21:40:58.777] Task URL: https://ci.chromium.org/b/8866881721598458832
[21:40:58.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:2:0) after 1m0s
[21:41:02.664] Received PubSub notification, asking Buildbucket for the build status
[21:41:02.754] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:58.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:2:0)
[21:41:58.803] Timer tick, asking Buildbucket for the build status
[21:41:59.295] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:59.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:4:0) after 1m0s
[21:42:59.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:4:0)
[21:42:59.321] Timer tick, asking Buildbucket for the build status
[21:42:59.594] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:59.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:5:0) after 1m0s
[21:43:59.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:5:0)
[21:43:59.699] Timer tick, asking Buildbucket for the build status
[21:43:59.926] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:59.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:6:0) after 1m0s
[21:44:59.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:6:0)
[21:44:59.954] Timer tick, asking Buildbucket for the build status
[21:45:00.159] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:00.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:7:0) after 1m0s
[21:46:00.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:7:0)
[21:46:00.147] Timer tick, asking Buildbucket for the build status
[21:46:00.484] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:00.484] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:8:0) after 1m0s
[21:47:02.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:8:0)
[21:47:02.339] Timer tick, asking Buildbucket for the build status
[21:47:02.490] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:02.490] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:9:0) after 1m0s
[21:48:02.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:9:0)
[21:48:02.528] Timer tick, asking Buildbucket for the build status
[21:48:02.605] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:02.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:10:0) after 1m0s
[21:49:03.081] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:10:0)
[21:49:03.081] Timer tick, asking Buildbucket for the build status
[21:49:03.157] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:03.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:11:0) after 1m0s
[21:50:03.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:11:0)
[21:50:03.621] Timer tick, asking Buildbucket for the build status
[21:50:03.677] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:03.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:12:0) after 1m0s
[21:51:03.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:12:0)
[21:51:03.796] Timer tick, asking Buildbucket for the build status
[21:51:03.955] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:03.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:13:0) after 1m0s
[21:52:04.383] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:13:0)
[21:52:04.384] Timer tick, asking Buildbucket for the build status
[21:52:04.459] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:04.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:14:0) after 1m0s
[21:53:04.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:14:0)
[21:53:04.553] Timer tick, asking Buildbucket for the build status
[21:53:04.653] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:04.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:15:0) after 1m0s
[21:54:04.741] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:15:0)
[21:54:04.741] Timer tick, asking Buildbucket for the build status
[21:54:04.803] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:04.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:16:0) after 1m0s
[21:55:04.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:16:0)
[21:55:04.853] Timer tick, asking Buildbucket for the build status
[21:55:04.973] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:04.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:17:0) after 1m0s
[21:56:05.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:17:0)
[21:56:05.121] Timer tick, asking Buildbucket for the build status
[21:56:05.408] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:05.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:18:0) after 1m0s
[21:57:05.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:18:0)
[21:57:05.460] Timer tick, asking Buildbucket for the build status
[21:57:05.624] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:05.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:19:0) after 1m0s
[21:58:05.725] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:19:0)
[21:58:05.725] Timer tick, asking Buildbucket for the build status
[21:58:05.797] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:05.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:20:0) after 1m0s
[21:59:05.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:20:0)
[21:59:05.864] Timer tick, asking Buildbucket for the build status
[21:59:05.973] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:05.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:21:0) after 1m0s
[22:00:06.050] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:21:0)
[22:00:06.050] Timer tick, asking Buildbucket for the build status
[22:00:06.181] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:06.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:22:0) after 1m0s
[22:01:06.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:22:0)
[22:01:06.351] Timer tick, asking Buildbucket for the build status
[22:01:06.813] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:06.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:23:0) after 1m0s
[22:02:06.940] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:23:0)
[22:02:06.940] Timer tick, asking Buildbucket for the build status
[22:02:07.045] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:07.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:24:0) after 1m0s
[22:03:07.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:24:0)
[22:03:07.073] Timer tick, asking Buildbucket for the build status
[22:03:07.146] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:07.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:25:0) after 1m0s
[22:04:07.160] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:25:0)
[22:04:07.160] Timer tick, asking Buildbucket for the build status
[22:04:07.488] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:07.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:26:0) after 1m0s
[22:05:07.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:26:0)
[22:05:07.538] Timer tick, asking Buildbucket for the build status
[22:05:07.595] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:07.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:27:0) after 1m0s
[22:06:07.597] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:27:0)
[22:06:07.597] Timer tick, asking Buildbucket for the build status
[22:06:07.737] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:07.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:28:0) after 1m0s
[22:07:07.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:28:0)
[22:07:07.778] Timer tick, asking Buildbucket for the build status
[22:07:07.860] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:07.860] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:29:0) after 1m0s
[22:08:07.941] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:29:0)
[22:08:07.941] Timer tick, asking Buildbucket for the build status
[22:08:08.037] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:08.037] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:30:0) after 1m0s
[22:09:08.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:30:0)
[22:09:08.062] Timer tick, asking Buildbucket for the build status
[22:09:08.140] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:08.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:31:0) after 1m0s
[22:10:08.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:31:0)
[22:10:08.205] Timer tick, asking Buildbucket for the build status
[22:10:08.309] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:08.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:32:0) after 1m0s
[22:11:08.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:32:0)
[22:11:08.400] Timer tick, asking Buildbucket for the build status
[22:11:08.499] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:08.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:33:0) after 1m0s
[22:12:08.554] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:33:0)
[22:12:08.554] Timer tick, asking Buildbucket for the build status
[22:12:08.614] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:08.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:34:0) after 1m0s
[22:13:08.645] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:34:0)
[22:13:08.645] Timer tick, asking Buildbucket for the build status
[22:13:08.703] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:08.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:35:0) after 1m0s
[22:14:08.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:35:0)
[22:14:08.792] Timer tick, asking Buildbucket for the build status
[22:14:08.898] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:08.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:36:0) after 1m0s
[22:15:08.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:36:0)
[22:15:08.938] Timer tick, asking Buildbucket for the build status
[22:15:09.219] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:09.219] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:37:0) after 1m0s
[22:16:09.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:37:0)
[22:16:09.231] Timer tick, asking Buildbucket for the build status
[22:16:09.336] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:09.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:38:0) after 1m0s
[22:17:09.398] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:38:0)
[22:17:09.398] Timer tick, asking Buildbucket for the build status
[22:17:09.524] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:09.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:39:0) after 1m0s
[22:18:09.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:39:0)
[22:18:09.517] Timer tick, asking Buildbucket for the build status
[22:18:10.042] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:10.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:40:0) after 1m0s
[22:19:10.094] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:40:0)
[22:19:10.094] Timer tick, asking Buildbucket for the build status
[22:19:10.211] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:10.211] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:41:0) after 1m0s
[22:20:10.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:41:0)
[22:20:10.262] Timer tick, asking Buildbucket for the build status
[22:20:10.591] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:10.591] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:42:0) after 1m0s
[22:21:10.640] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:42:0)
[22:21:10.640] Timer tick, asking Buildbucket for the build status
[22:21:11.080] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:11.080] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:43:0) after 1m0s
[22:22:11.119] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:43:0)
[22:22:11.119] Timer tick, asking Buildbucket for the build status
[22:22:11.330] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:11.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:44:0) after 1m0s
[22:23:11.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:44:0)
[22:23:11.388] Timer tick, asking Buildbucket for the build status
[22:23:11.459] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:11.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:45:0) after 1m0s
[22:24:11.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:45:0)
[22:24:11.512] Timer tick, asking Buildbucket for the build status
[22:24:11.757] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:11.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:46:0) after 1m0s
[22:25:11.865] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:46:0)
[22:25:11.865] Timer tick, asking Buildbucket for the build status
[22:25:11.950] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:11.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:47:0) after 1m0s
[22:26:12.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:47:0)
[22:26:12.002] Timer tick, asking Buildbucket for the build status
[22:26:12.185] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:12.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:48:0) after 1m0s
[22:27:12.202] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:48:0)
[22:27:12.202] Timer tick, asking Buildbucket for the build status
[22:27:12.267] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:12.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:49:0) after 1m0s
[22:28:12.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:49:0)
[22:28:12.323] Timer tick, asking Buildbucket for the build status
[22:28:12.455] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:12.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:50:0) after 1m0s
[22:29:12.572] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:50:0)
[22:29:12.572] Timer tick, asking Buildbucket for the build status
[22:29:12.707] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:12.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:51:0) after 1m0s
[22:30:12.764] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:51:0)
[22:30:12.764] Timer tick, asking Buildbucket for the build status
[22:30:13.305] Build 8866881721598458832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:13.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032311783761652400:52:0) after 1m0s
[22:30:49.744] Received PubSub notification, asking Buildbucket for the build status
[22:30:50.137] Build 8866881721598458832: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:30:50.137] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602282648743740",
"created_by": "project:chromium",
"created_ts": "1602279657707099",
"id": "8866881721598458832",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"15b71141882153c6434ab8858b8d017151e2003e\"}}",
"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\": \"15b71141882153c6434ab8858b8d017151e2003e\", \"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-67-st7i\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 176507, \"got_angle_revision\": \"b2ff69f856d98312bbfe14f80d084b7d8795281f\", \"got_dawn_revision\": \"793a07e366362f2e3cdf07e144c1eff8de18efba\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"15b71141882153c6434ab8858b8d017151e2003e\", \"got_revision_cp\": \"refs/heads/master@{#815801}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"0aca3ca9427d1d2aa8d8e706de62360c61af3598\", \"got_v8_revision\": \"e4ed803f4c09ff72bb1eaadf59ec31facf507368\", \"got_v8_revision_cp\": \"refs/heads/8.8.64@{#1}\", \"got_webrtc_revision\": \"ff7913204ce23f6888d206d16250a1429d0736db\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32372}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"15b71141882153c6434ab8858b8d017151e2003e\", \"swarm_hashes_refs/heads/master(at){#815801}_without_patch\": {\"absl_hardening_tests\": \"a173f4dc49dc9e5443221a812ce2683dd46409a9\", \"accessibility_unittests\": \"e35ac901f731d90dd19057b9447443216bff56f7\", \"app_shell_unittests\": \"8c9c07d8474d727d0aab67554b1aa033c36da9a4\", \"aura_unittests\": \"7ba0ff45f4fe745ef3e6396b5f3e7b44e3e9a0f9\", \"base_unittests\": \"94fd9d86986477e5d80f73da41f9cece99359ad6\", \"base_util_unittests\": \"ec55b2a290aa8a15929601370efde779ba12cded\", \"blink_common_unittests\": \"9ce9f6f9dc50f6b7aede6a781ef9d167bc505b75\", \"blink_fuzzer_unittests\": \"09692bfba036b79ffae1be1013851313778652fd\", \"blink_heap_unittests\": \"92e999ff5199343411dd4e5d4a7d3485d6a2e864\", \"blink_platform_unittests\": \"29cbd4d86daca8e157688020d6587e03f81a6acd\", \"blink_python_tests\": \"5078ad6c91545cebdd167a6ff1fc6123b0c06ff9\", \"blink_unittests\": \"c688ac67abd3c7c46d88c419740c1502948d5ba6\", \"blink_web_tests\": \"7cd1f74218cfacddec60b6fd5b9c282c48acef9b\", \"boringssl_crypto_tests\": \"dc9b2f9d71f27db45641db518d53087c1148b5e0\", \"boringssl_ssl_tests\": \"6f640201cc8ab052e7d22ac28010324baf798e14\", \"browser_tests\": \"98618ac888832d0bc74c44d8238ce163e6413378\", \"capture_unittests\": \"27a4ef1aa14280f2ef6592c37523f86b436a9f51\", \"cast_unittests\": \"e717328122d0dc0b4d079f7d2c9ef7d55218326f\", \"cc_unittests\": \"ac6d12375e390e415f86f7147b39e01dd54d121d\", \"chrome_app_unittests\": \"adeebaa5e951c117580c035d74b3b87af7558666\", \"chromedriver_unittests\": \"bcb71ba078f12d64174daa8b7732510cb3f24c50\", \"components_browsertests\": \"51daef0fdd25dbf13a2521d9c3bc510bcac8483c\", \"components_unittests\": \"64cd68bfe17338a86d739cff0b2164bb49f5695e\", \"compositor_unittests\": \"2459f9641746569bacecedf607a9fa334d20e45a\", \"content_browsertests\": \"a4a910377f0541398cd62dde19526546b6b19193\", \"content_shell_crash_test\": \"db0a75d4563dc90a350aaa94629ff1498aad865d\", \"content_unittests\": \"f9d2caac6c7be2df9cf03250684b85e679fe3321\", \"crashpad_tests\": \"4dd823f1653abdd57b7d2eab64ec5f6cdb03c15b\", \"cronet_tests\": \"12e32c154cc514e80e16d439dc2e98a7d3cc44c3\", \"cronet_unittests\": \"0085a33f9638d671fba9ade0fbea46adcf773d9b\", \"crypto_unittests\": \"13c9ee3a22140b45ee1a2c4c8b4019e46ad3479c\", \"dbus_unittests\": \"6ca17005898f746e259c634901ce16c758af135b\", \"device_unittests\": \"823f5a0c75c3de669d550248182c9192ab8a364b\", \"display_unittests\": \"36cd8f53729e3ad266c01b5d46a4f6c7ced91f4e\", \"events_unittests\": \"226d755f4da7866d4e9456ce0b24f53efd62c846\", \"extension_docserver_python_unittests\": \"9e07c383868e294c399248635a054c66261bdb48\", \"extensions_browsertests\": \"f467f8a349f2ad73a0a3a195cef3d19d6d502629\", \"extensions_unittests\": \"b3e6c86e72403d9394fd3020690762ce7c8a3dc3\", \"filesystem_service_unittests\": \"404226d58b8ba025c1b9892a23d2ecb78b7eb5a0\", \"flatbuffers_unittests\": \"7c821f13730963d6e07deae074f4fffab315d766\", \"gcm_unit_tests\": \"4800315995882b1f917c8868f0855ea1970e1752\", \"gfx_unittests\": \"47c174cce20418e37b904a4daa508ddf49ca84b9\", \"gin_unittests\": \"52ebc7b91d80019e690a886d26ae2ebd9b7d5368\", \"google_apis_unittests\": \"3624d77147aa2a4d839d8c2c51a450cbf8d1db9e\", \"gpu_unittests\": \"7186fc0abaeb5ef5b4f810e57ee5996e21e6fb12\", \"grit_python_unittests\": \"55fa961d85005331568451ce869e032331bd4b90\", \"gwp_asan_unittests\": \"a905ca9b6b9480fc00a0c4106a193f35b469abcb\", \"headless_browsertests\": \"0f7aef415e6038a83677cf67fa3cd2a6253e4ff7\", \"headless_unittests\": \"f97956dd2e39e404b887fd8b39b7cd796c07e9ab\", \"interactive_ui_tests\": \"a6fd4dfab8925e1e4577845f9bd411a5eceb8838\", \"ipc_tests\": \"454f804e5772f272218b6bc7255174dd93bbe649\", \"jingle_unittests\": \"d339ddded540ccceb916d074080f740987ad47f1\", \"latency_unittests\": \"a8093e380411370220310a26d848a89e3fae448f\", \"libjingle_xmpp_unittests\": \"9633e03643c58588266d279bde38a024bfdb9b73\", \"media_blink_unittests\": \"689e39828adb17f7dce7fac15c30edec69ddea17\", \"media_unittests\": \"80d478ef79e70699aa9049a60f9323f536dcc0b8\", \"message_center_unittests\": \"1c8940ca3e49b4347399660e9b7e8626fa602460\", \"metrics_python_tests\": \"43e87e244101d73a9dff32c86a1c0dfbb88c3873\", \"midi_unittests\": \"5ae2efa2e8bee7fa21d06355ee012190afcb7715\", \"mojo_core_unittests\": \"c5ce50127dc43e4651cf2bd01e0885837323b59e\", \"mojo_unittests\": \"a758f2aa70dc88b243577617632d01680c3f7d0f\", \"nacl_helper_nonsfi_unittests\": \"e7ad4784f0b843f7391f4b353f6026c16b294f7c\", \"nacl_loader_unittests\": \"c0118cea5337f40b8fd822f2bd3f569817959680\", \"native_theme_unittests\": \"2f0f3e1819adcd73fd667f5d3543947deb341570\", \"net_unittests\": \"4440830724b344ed8ba4199c418d4e12bc60092f\", \"openscreen_unittests\": \"48b4c192f7ccce0283be134af4bc12a9ca2bc26e\", \"pdf_unittests\": \"e65a799a8429130c91884c6fdb1b2d3d97c6ec50\", \"perfetto_unittests\": \"bab85377c29a313fc8ff603f6b8784d3db201076\", \"ppapi_unittests\": \"bbe84efb92984d2fc9e41fee62f7f2b0849dff0d\", \"printing_unittests\": \"6520741dc3d19efb900f5e91d270c430c3578af8\", \"remoting_unittests\": \"b1b8e94aa547ed11051d44416dd26fa9fe3fe411\", \"sandbox_linux_unittests\": \"efdd4e571400bc7b50636cb346a4f538f35f09f3\", \"service_manager_unittests\": \"9dfc5aae515b294891400a066106ef51ce96f49a\", \"services_unittests\": \"ee2e2ba6af5babb5232049dccaebaf3e9ce7be9c\", \"shell_dialogs_unittests\": \"46f14c0c5ec1e0806b22c9002b96d99f32edaab1\", \"skia_unittests\": \"55eec9753a38805e072c8793b3a4fc411ddd5e9a\", \"snapshot_unittests\": \"a118097764b6b3a393f32cde26444bc8a62e5b8b\", \"sql_unittests\": \"d0d6d916a1026ac46c17cdc86d352fec5a20402c\", \"standalone_angle_unittests\": \"f16b025e43964c0e347dbdcda13bf3e7e228f5b1\", \"storage_unittests\": \"1cf859a58158b369d054ed8ed65a8303f64a6fbc\", \"sync_integration_tests\": \"0ac5166094c22fc94bd33a95eea08e9de027e786\", \"telemetry_gpu_unittests\": \"c14e3170d4680026c8e519ea61cd0a2af4408915\", \"telemetry_perf_unittests\": \"e8b5f98dffe938bbf804d6fed13b78e2eb43d609\", \"telemetry_unittests\": \"200a663419971bf25270dbbb695b83d01b76ff09\", \"traffic_annotation_auditor_unittests\": \"3f63cb29a77d3685423056fff8b9da7353a8e4cd\", \"ui_base_unittests\": \"5e23874504c906952f73624350e4e24d0b8424ea\", \"ui_touch_selection_unittests\": \"d58e6aeb056e53424eedd27b789fe7aa96ddef6a\", \"unit_tests\": \"00dbb55cff79f47c0084b4ea7359bccb822a8761\", \"url_unittests\": \"ee0ec7b0a200182fa011c29125d98367f75df4b2\", \"views_perftests\": \"265dffa6c8903a6ab7951bae320d8373e72334fa\", \"views_unittests\": \"41cf0dfef734b611d396a459a2dc342430a1430a\", \"viz_unittests\": \"74c9155cd6fbad17cd85add8a8961cbc524f7504\", \"vr_common_unittests\": \"abfae2f18459f8611d8094ad58bb69e4882339de\", \"vr_pixeltests\": \"a77d989cef9df7cd65678fff7d95cedfde621141\", \"webdriver_wpt_tests\": \"b281eed3a3e33e494fe55fbbeec63fbc5a4d9736\", \"weblayer_browsertests\": \"ed4ca126e42950d2d7ba9597c54b8123beb46a5a\", \"weblayer_unittests\": \"c91e5b31b0b67c1e9b2ea8f217afba37f17770a4\", \"wm_unittests\": \"f53e5d1fc1b646e2b1def82fd57ebe00ce710936\", \"wtf_unittests\": \"92cc21ee7929ef3f516d5e9e03705dae9fb61a18\", \"x11_unittests\": \"c1d131607db5631f8661756ba368911db76d46eb\", \"xr_browser_tests\": \"6af6804eabb16e62ae767cf01eee2f976068e6d6\", \"zlib_unittests\": \"19c461d0b6bd9b0e7ea388ec5818dfe02aaac29f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_387e931c7b633ee2f48b892df14288ffa2061feda74b30444810d565fa474120_v2\", \"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_609b54f795c46f6da98bce3e3c3edeb2c2e2d72c7759cc5040a86edccd734c7c_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_e7fd4b7a9e211f8d968af60263c508e13e49814167aff980c2bf239c05ea48ef_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-67-st7i\"], \"image\": [\"chrome-xenial-20100700-ace2c028da3\"], \"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\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602279661710842",
"status": "COMPLETED",
"status_changed_ts": "1602282649495808",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176507",
"builder:Linux Builder (dbg)",
"buildset:commit/git/15b71141882153c6434ab8858b8d017151e2003e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/15b71141882153c6434ab8858b8d017151e2003e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032311783761652400",
"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/8866881721598458832/+/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:4f2820dd70dc3f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1602282649501285",
"url": "https://ci.chromium.org/b/8866881721598458832",
"utcnow_ts": "1602282650102403"
}
}
[22:30:50.137] Invocation finished in 49m53.877540144s with status SUCCEEDED