[08:26:11.399] New invocation is queued and will start shortly
[08:26:13.926] Starting the invocation (attempt 1)
[08:26:13.977] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:26:13.977] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:26:13.978] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9056551175015356144",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"58f3dbfdcd376056f1162bda406e0c2fb5ae3f3d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9056551175015356144",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/58f3dbfdcd376056f1162bda406e0c2fb5ae3f3d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/58f3dbfdcd376056f1162bda406e0c2fb5ae3f3d",
"gitiles_ref:refs/heads/master"
]
}
[08:26:15.975] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1579163174134279",
"id": "8891121111477062848",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"58f3dbfdcd376056f1162bda406e0c2fb5ae3f3d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1579163174683779",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167439",
"builder:Linux Builder (dbg)",
"buildset:commit/git/58f3dbfdcd376056f1162bda406e0c2fb5ae3f3d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/58f3dbfdcd376056f1162bda406e0c2fb5ae3f3d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056551175015356144",
"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/8891121111477062848/+/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": "1579163174683947",
"url": "https://ci.chromium.org/b/8891121111477062848",
"utcnow_ts": "1579163175957683"
}
}
[08:26:15.975] Task URL: https://ci.chromium.org/b/8891121111477062848
[08:26:15.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:2:0) after 1m0s
[08:27:16.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:2:0)
[08:27:16.138] Timer tick, asking Buildbucket for the build status
[08:27:17.759] Build 8891121111477062848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:27:17.759] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:3:0) after 1m0s
[08:28:18.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:3:0)
[08:28:18.035] Timer tick, asking Buildbucket for the build status
[08:28:19.082] Build 8891121111477062848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:28:19.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:4:0) after 1m0s
[08:29:19.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:4:0)
[08:29:19.154] Timer tick, asking Buildbucket for the build status
[08:29:19.289] Build 8891121111477062848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:29:19.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:5:0) after 1m0s
[08:30:19.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:5:0)
[08:30:19.369] Timer tick, asking Buildbucket for the build status
[08:30:19.859] Build 8891121111477062848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:30:19.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:6:0) after 1m0s
[08:31:05.881] Received PubSub notification, asking Buildbucket for the build status
[08:31:06.104] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:20.016] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:6:0)
[08:31:20.016] Timer tick, asking Buildbucket for the build status
[08:31:20.716] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:20.716] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:8:0) after 1m0s
[08:32:20.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:8:0)
[08:32:20.824] Timer tick, asking Buildbucket for the build status
[08:32:21.054] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:21.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:9:0) after 1m0s
[08:33:21.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:9:0)
[08:33:21.127] Timer tick, asking Buildbucket for the build status
[08:33:21.983] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:21.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:10:0) after 1m0s
[08:34:22.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:10:0)
[08:34:22.064] Timer tick, asking Buildbucket for the build status
[08:34:22.492] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:22.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:11:0) after 1m0s
[08:35:22.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:11:0)
[08:35:22.546] Timer tick, asking Buildbucket for the build status
[08:35:22.894] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:22.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:12:0) after 1m0s
[08:36:22.947] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:12:0)
[08:36:22.947] Timer tick, asking Buildbucket for the build status
[08:36:23.096] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:23.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:13:0) after 1m0s
[08:37:23.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:13:0)
[08:37:23.117] Timer tick, asking Buildbucket for the build status
[08:37:25.557] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:25.557] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:14:0) after 1m0s
[08:38:25.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:14:0)
[08:38:25.642] Timer tick, asking Buildbucket for the build status
[08:38:26.518] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:26.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:15:0) after 1m0s
[08:39:26.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:15:0)
[08:39:26.520] Timer tick, asking Buildbucket for the build status
[08:39:26.692] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:26.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:16:0) after 1m0s
[08:40:26.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:16:0)
[08:40:26.814] Timer tick, asking Buildbucket for the build status
[08:40:27.024] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:27.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:17:0) after 1m0s
[08:41:27.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:17:0)
[08:41:27.112] Timer tick, asking Buildbucket for the build status
[08:41:27.389] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:27.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:18:0) after 1m0s
[08:42:27.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:18:0)
[08:42:27.541] Timer tick, asking Buildbucket for the build status
[08:42:27.697] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:27.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:19:0) after 1m0s
[08:43:27.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:19:0)
[08:43:27.749] Timer tick, asking Buildbucket for the build status
[08:43:27.902] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:27.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:20:0) after 1m0s
[08:44:27.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:20:0)
[08:44:27.963] Timer tick, asking Buildbucket for the build status
[08:44:28.851] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:28.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:21:0) after 1m0s
[08:45:28.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:21:0)
[08:45:28.853] Timer tick, asking Buildbucket for the build status
[08:45:29.076] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:29.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:22:0) after 1m0s
[08:46:29.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:22:0)
[08:46:29.167] Timer tick, asking Buildbucket for the build status
[08:46:29.422] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:29.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:23:0) after 1m0s
[08:47:29.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:23:0)
[08:47:29.434] Timer tick, asking Buildbucket for the build status
[08:47:29.875] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:29.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:24:0) after 1m0s
[08:48:29.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:24:0)
[08:48:29.857] Timer tick, asking Buildbucket for the build status
[08:48:30.581] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:30.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:25:0) after 1m0s
[08:49:30.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:25:0)
[08:49:30.630] Timer tick, asking Buildbucket for the build status
[08:49:32.305] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:32.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:26:0) after 1m0s
[08:50:32.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:26:0)
[08:50:32.324] Timer tick, asking Buildbucket for the build status
[08:50:33.474] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:33.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:27:0) after 1m0s
[08:51:33.467] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:27:0)
[08:51:33.467] Timer tick, asking Buildbucket for the build status
[08:51:33.628] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:33.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:28:0) after 1m0s
[08:52:33.687] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:28:0)
[08:52:33.687] Timer tick, asking Buildbucket for the build status
[08:52:34.110] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:34.110] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:29:0) after 1m0s
[08:53:34.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:29:0)
[08:53:34.269] Timer tick, asking Buildbucket for the build status
[08:53:34.441] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:34.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:30:0) after 1m0s
[08:54:34.472] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:30:0)
[08:54:34.472] Timer tick, asking Buildbucket for the build status
[08:54:34.614] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:34.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:31:0) after 1m0s
[08:55:34.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:31:0)
[08:55:34.698] Timer tick, asking Buildbucket for the build status
[08:55:34.883] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:34.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:32:0) after 1m0s
[08:56:34.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:32:0)
[08:56:34.919] Timer tick, asking Buildbucket for the build status
[08:56:35.073] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:35.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:33:0) after 1m0s
[08:57:35.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:33:0)
[08:57:35.124] Timer tick, asking Buildbucket for the build status
[08:57:35.586] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:35.586] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:34:0) after 1m0s
[08:58:35.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:34:0)
[08:58:35.642] Timer tick, asking Buildbucket for the build status
[08:58:35.843] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:35.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:35:0) after 1m0s
[08:59:36.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:35:0)
[08:59:36.056] Timer tick, asking Buildbucket for the build status
[08:59:36.663] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:36.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:36:0) after 1m0s
[09:00:36.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:36:0)
[09:00:36.786] Timer tick, asking Buildbucket for the build status
[09:00:37.445] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:37.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:37:0) after 1m0s
[09:01:37.478] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:37:0)
[09:01:37.478] Timer tick, asking Buildbucket for the build status
[09:01:37.703] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:37.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:38:0) after 1m0s
[09:02:37.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:38:0)
[09:02:37.797] Timer tick, asking Buildbucket for the build status
[09:02:38.289] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:38.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:39:0) after 1m0s
[09:03:38.343] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:39:0)
[09:03:38.343] Timer tick, asking Buildbucket for the build status
[09:03:38.600] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:38.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:40:0) after 1m0s
[09:04:38.669] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:40:0)
[09:04:38.669] Timer tick, asking Buildbucket for the build status
[09:04:39.612] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:39.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:41:0) after 1m0s
[09:05:39.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:41:0)
[09:05:39.695] Timer tick, asking Buildbucket for the build status
[09:05:40.153] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:40.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:42:0) after 1m0s
[09:06:40.188] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:42:0)
[09:06:40.188] Timer tick, asking Buildbucket for the build status
[09:06:40.672] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:40.672] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:43:0) after 1m0s
[09:07:40.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:43:0)
[09:07:40.740] Timer tick, asking Buildbucket for the build status
[09:07:41.179] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:41.179] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:44:0) after 1m0s
[09:08:41.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:44:0)
[09:08:41.262] Timer tick, asking Buildbucket for the build status
[09:08:41.582] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:41.582] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:45:0) after 1m0s
[09:09:41.581] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:45:0)
[09:09:41.581] Timer tick, asking Buildbucket for the build status
[09:09:41.935] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:41.935] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:46:0) after 1m0s
[09:10:42.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:46:0)
[09:10:42.056] Timer tick, asking Buildbucket for the build status
[09:10:42.273] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:42.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:47:0) after 1m0s
[09:11:42.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:47:0)
[09:11:42.293] Timer tick, asking Buildbucket for the build status
[09:11:42.550] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:42.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:48:0) after 1m0s
[09:12:42.579] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:48:0)
[09:12:42.579] Timer tick, asking Buildbucket for the build status
[09:12:42.811] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:42.811] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:49:0) after 1m0s
[09:13:42.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:49:0)
[09:13:42.852] Timer tick, asking Buildbucket for the build status
[09:13:43.456] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:43.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:50:0) after 1m0s
[09:14:43.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:50:0)
[09:14:43.600] Timer tick, asking Buildbucket for the build status
[09:14:44.197] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:44.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:51:0) after 1m0s
[09:15:44.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:51:0)
[09:15:44.283] Timer tick, asking Buildbucket for the build status
[09:15:44.536] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:44.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:52:0) after 1m0s
[09:16:44.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:52:0)
[09:16:44.619] Timer tick, asking Buildbucket for the build status
[09:16:45.601] Build 8891121111477062848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:45.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056551175015356144:53:0) after 1m0s
[09:16:57.185] Received PubSub notification, asking Buildbucket for the build status
[09:16:57.298] Build 8891121111477062848: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:16:57.298] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1579166216256752",
"created_by": "project:chromium",
"created_ts": "1579163174134279",
"id": "8891121111477062848",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"58f3dbfdcd376056f1162bda406e0c2fb5ae3f3d\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"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-98-dtpj\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 167439, \"got_angle_revision\": \"a7b91502cd7fc8868ccb14dbd3a9d70ced5160ec\", \"got_dawn_revision\": \"0ecc48ecb7a1353b9e1a3cd9d3a125f6a770477c\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"58f3dbfdcd376056f1162bda406e0c2fb5ae3f3d\", \"got_revision_cp\": \"refs/heads/master@{#732314}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"5fc197dc76693d0049d1f400a077f13fa1f6078b\", \"got_v8_revision\": \"3b5fd1756617330f4654696e78503a7a3a07278f\", \"got_v8_revision_cp\": \"refs/heads/8.1.188@{#1}\", \"got_webrtc_revision\": \"52ccb5e5b6e720d83269259be696797c55a7c642\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30275}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"58f3dbfdcd376056f1162bda406e0c2fb5ae3f3d\", \"swarm_hashes_refs/heads/master(at){#732314}_without_patch\": {\"accessibility_unittests\": \"ca57d542234c538c60ba9f18982188901a048841\", \"angle_unittests\": \"f4888346b917cb978b26ef8ddb10ad2d67d1eb1c\", \"app_shell_unittests\": \"25be6034f4f46c284a72d41eedc4bf17799fc23c\", \"aura_unittests\": \"b97a71258101a69b0e3d9ff047b639448eef8f11\", \"base_unittests\": \"204f42f39a2248fd8363e87322e5bc05d0a1124e\", \"base_util_unittests\": \"7c1981453d67a8530852a502473d0ffb596b27f7\", \"blink_common_unittests\": \"5f9b93db15f0bf3b74af174c0b34221a2e29b7b6\", \"blink_fuzzer_unittests\": \"e49fcffc4f854821b2ae517eb45607f8d36e3710\", \"blink_heap_unittests\": \"134d7bf00e3dc2a0933da135d01170fc389ba960\", \"blink_platform_unittests\": \"ec9ed073e634afa40af370d7e1420252d2d94a5c\", \"blink_python_tests\": \"9420db063f66dcd0ecc515a6db6cddb4cc69e27e\", \"blink_unittests\": \"32a96cb29d8bd5ea17f391899f6681522541a9f3\", \"blink_web_tests\": \"2c055b5c65039c4265880eddae3dcdac0b9c9153\", \"boringssl_crypto_tests\": \"52023df9abd9ccdafc62ae45b05dafc799590d03\", \"boringssl_ssl_tests\": \"6915386fc21428eb1e0a66d1717535e5f5b894b2\", \"browser_tests\": \"46eb7fed29b7877f2d6b8b41b00bb16da7ac1b96\", \"cacheinvalidation_unittests\": \"b88ee07acd522198620f7b9113683452a1b3b258\", \"capture_unittests\": \"1d752e8a9fe60f6d1d34ea3e9ffa5e53db351ebd\", \"cast_unittests\": \"93dbefa12cca0a976090fe525853154ad1167b21\", \"cc_unittests\": \"201d75378f6fd6214924883021ae1571b1695744\", \"chrome_app_unittests\": \"2a472c6b463275a6706fee99b7b143376c2d50d0\", \"chromedriver_unittests\": \"5940726ba2d136c94cbd3e00529a95989297d61c\", \"components_browsertests\": \"12cb97fd289c293dad424e2c8c618a1a18cdf63e\", \"components_unittests\": \"71e7cdf729251d3b06037918f67285c432fc137b\", \"compositor_unittests\": \"378e6c051b39aeeae5ccb5954470a8bb4e9efa5d\", \"content_browsertests\": \"de564f7133d5a95ec7b00ff09576f2f444be6295\", \"content_shell_crash_test\": \"99b2e3a35dc0e552bcc9784e0b0d3f8ef3b17ec0\", \"content_unittests\": \"c561f16febfcdefc0c4c649c29d04a95103fc446\", \"crashpad_tests\": \"183c4d00f5ee999d2533c12fb9dcff11ce287bd3\", \"cronet_tests\": \"6d82ad53c547e0892552122650c778154f3b1ab0\", \"cronet_unittests\": \"841671f6bcd51711b56e8d27214dc921ffeafae1\", \"crypto_unittests\": \"9c743281934126dae9770c663471d12d4728640f\", \"dbus_unittests\": \"59115495897952ebe0432b25c6ad4d49129362d9\", \"device_unittests\": \"ceb5b9ad2d7b8dc04b15c842919059fba0cac69d\", \"devtools_lint_check\": \"705b2cde109793ab4d46662c636abc4461aa1cd9\", \"devtools_type_check\": \"dbc1df6511337a461edad7c4534b989703ce4fef\", \"display_unittests\": \"dbe8318492f819647d328652e253daa7a772b00c\", \"events_unittests\": \"19f0d70c6efe671e2efdb94222a5be44a7cfeaec\", \"extensions_browsertests\": \"74ab8bcbbd26b6e8c3338c139efd37be9ca075cc\", \"extensions_unittests\": \"980739dd8d0f8113caea3d1f886d5c2fc062cf16\", \"filesystem_service_unittests\": \"2fff79107a881ab0087218f2c49107797438ce38\", \"flatbuffers_unittests\": \"92c174f535dbe8e15f58589d59dc88efc29a10d4\", \"gcm_unit_tests\": \"c22c57cdd81945fade19257fff1f3713eedcf5d8\", \"gfx_unittests\": \"3ebb0c8d15e8dd9b151c3d544d36977d69ba7ecb\", \"gin_unittests\": \"07d3a749e3748888123edbcb719d352e4be5a583\", \"google_apis_unittests\": \"7276ffd75b2c04f8d18b5e3d3ae372cecfc31003\", \"gpu_unittests\": \"aecd7962a05ce50e9942e1f6dbc59ae94f620295\", \"grit_python_unittests\": \"5ba70f2d123ffe8977591ea0b82d6185e7fe166f\", \"gwp_asan_unittests\": \"212db6d68361b3d0ed80b60917b84c7e06e7e69f\", \"headless_browsertests\": \"5a99557216804c23e6c05090e2eb9af1524a250d\", \"headless_unittests\": \"4341cb03e168858e98516088d510d3ca59da59eb\", \"interactive_ui_tests\": \"35adcf9be72e975b1b9ef82e56eafc87a21a43f3\", \"ipc_tests\": \"ba4d4b87abf8d128c3326bc712586696a1007c01\", \"jingle_unittests\": \"8fea560e083364a67a08a698124ea1680cf60bd2\", \"latency_unittests\": \"262b2bf623e2448d31a110c2c6b6db7bc86e1c14\", \"libjingle_xmpp_unittests\": \"c6da85b47334950461c0845772da42d9c5ec5909\", \"media_blink_unittests\": \"d157c22c9f58a1dd80ea52f07593ee1a2ec78ce8\", \"media_service_unittests\": \"c8c82a6a29ea82c5f29941fb5f81293faaab600f\", \"media_unittests\": \"f14f2cb979b9be69160985cf09e0bb864721c0d3\", \"message_center_unittests\": \"32911f8c473e199b9fe31acbb5a19d86f7e4045b\", \"metrics_python_tests\": \"7c4a78cd633a26873f39b2c8db43f4fb479c88c8\", \"midi_unittests\": \"c7ae54935e28b4d45cc97c6a6165399a8e927969\", \"mojo_core_unittests\": \"da3c70644282370f531034256854b69392e752ef\", \"mojo_unittests\": \"2eb37337933a0345d1b7fb184216f339523d772f\", \"nacl_helper_nonsfi_unittests\": \"124a735daf1b263a5a122ebf5c1ac268e6434208\", \"nacl_loader_unittests\": \"4d27a6295f58e6c292a39861748e8cd5c91dc7c6\", \"native_theme_unittests\": \"e7da91e3090f62ff2b698f1308f5c8dd343621d3\", \"net_unittests\": \"434611a5c540f5c14613cdd9ecf9f2566ad0dd99\", \"pdf_unittests\": \"791f243c2cdbfe03c5cbefc995544ba8dd3fbb27\", \"perfetto_unittests\": \"0f0dcd3688796bb99a59d9603f0d470654bc7e3d\", \"ppapi_unittests\": \"e77cf6b690681c2952b4a6e14f37fbad732090aa\", \"printing_unittests\": \"5fab29ff0b9e0307e4eca7cc67c46615f0a1107e\", \"remoting_unittests\": \"f79242f15cb598fa7d22bc01eb4ea2fda6c90662\", \"sandbox_linux_unittests\": \"849cf6b019eb8af451e60b17dde0ba4e52cb9723\", \"service_manager_unittests\": \"59ef779d14974a4b5c305fb83dcce6d0485a04f2\", \"services_unittests\": \"e766cfac84887833429f484c5abad75e9cd820fe\", \"shell_dialogs_unittests\": \"4812cbac0e9784e0b52cee58c980234fdb099535\", \"skia_unittests\": \"814377c7cb9d0d7f58f1eb976e8d146d5dc08995\", \"snapshot_unittests\": \"538936687c654414b775dce516a892fd01b13203\", \"sql_unittests\": \"ef8537634163d7d9f91a3f04406e6a175f9c3888\", \"storage_unittests\": \"04264e165ddd07e708e81be7e6bfd402c7fa76ca\", \"sync_integration_tests\": \"ef98754e4f760564294d4f1d15bed9766c815852\", \"telemetry_gpu_unittests\": \"809b9f54e23ed732058c915f7cdd0f08209f5aa6\", \"telemetry_perf_unittests\": \"7cbaf9ff8e5afb6570ce8098df2f4376224d04af\", \"telemetry_unittests\": \"51233e010b5d638cafd3c2c82a4ea71a0db7b877\", \"traffic_annotation_auditor_unittests\": \"ce9ed002dacb8b14ffd15e2986d1cd924bf3c6a2\", \"ui_base_unittests\": \"43e6a12a727c978a245b15fdf4a8d3e5e4c869b2\", \"ui_touch_selection_unittests\": \"f87af784faef2a1e58e44274dab9baec02407eb3\", \"unit_tests\": \"124209b55daa52fe72a0d1a96414c7dcbbff8e18\", \"url_unittests\": \"4cb5b97626512bbe1a28afaa449d6125dbc8d84a\", \"views_perftests\": \"4da5f4673a64d8273f9c73faad78501b468fad55\", \"views_unittests\": \"ff2f5ae13a70349304e0bbd2e64af01e68e37fc1\", \"viz_unittests\": \"ed87b600f24adefb43bb8801afd22131f489056c\", \"vr_common_unittests\": \"4fc0973c009d55690f62df208c15e25c09c428f2\", \"vr_pixeltests\": \"12c42c149b4bc1bce38242fe76534582d139ed41\", \"webdriver_wpt_tests\": \"41325a4f28f0468f37d1e522e2560ce52419e92f\", \"weblayer_browsertests\": \"93f2d86b2cc861a0811c3380bc2e476c06673475\", \"wm_unittests\": \"2bf553c5bb13dd9bf881e802279183f7ae6c339c\", \"wtf_unittests\": \"ed733849dd976afa9451598275e5afb4cd44ab80\", \"xr_browser_tests\": \"12401d7df0658184aa2b8f954d86cd9c4813e141\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_86caf262f74ae694bec00fbb86541daa2df96eb35c1a4d9a06c3c1dcd129237e_v2\", \"builder_a2762fc34916ccddaf93df3ba974050968da64cd82521aaf473d97885fea8846_v2\", \"builder_eeb4aed1f5957a78d1f0fe1c00bdb778895591d08c1bb63c47ebb234324ef661_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-98-dtpj\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"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\": [\"4760-d9a0e6d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1579163464827123",
"status": "COMPLETED",
"status_changed_ts": "1579166216717062",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167439",
"builder:Linux Builder (dbg)",
"buildset:commit/git/58f3dbfdcd376056f1162bda406e0c2fb5ae3f3d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/58f3dbfdcd376056f1162bda406e0c2fb5ae3f3d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056551175015356144",
"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/8891121111477062848/+/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:49c64752439e4210",
"user_agent:luci-scheduler"
],
"updated_ts": "1579166216728047",
"url": "https://ci.chromium.org/b/8891121111477062848",
"utcnow_ts": "1579166217289624"
}
}
[09:16:57.298] Invocation finished in 50m45.920827606s with status SUCCEEDED