[19:02:34.450] New invocation is queued and will start shortly
[19:02:35.851] Starting the invocation (attempt 1)
[19:02:35.893] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:02:35.893] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:02:35.893] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9056511137180405552",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"97805ec6aa2332b49b72c6ff9b3b23404f1f8fb3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9056511137180405552",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/97805ec6aa2332b49b72c6ff9b3b23404f1f8fb3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97805ec6aa2332b49b72c6ff9b3b23404f1f8fb3",
"gitiles_ref:refs/heads/master"
]
}
[19:02:39.391] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1579201356279266",
"id": "8891081074596420368",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"97805ec6aa2332b49b72c6ff9b3b23404f1f8fb3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1579201359006279",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167460",
"builder:Linux Builder (dbg)",
"buildset:commit/git/97805ec6aa2332b49b72c6ff9b3b23404f1f8fb3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97805ec6aa2332b49b72c6ff9b3b23404f1f8fb3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056511137180405552",
"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/8891081074596420368/+/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": "1579201359006397",
"url": "https://ci.chromium.org/b/8891081074596420368",
"utcnow_ts": "1579201359343613"
}
}
[19:02:39.391] Task URL: https://ci.chromium.org/b/8891081074596420368
[19:02:39.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:2:0) after 1m0s
[19:03:39.501] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:2:0)
[19:03:39.501] Timer tick, asking Buildbucket for the build status
[19:03:40.062] Build 8891081074596420368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:03:40.062] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:3:0) after 1m0s
[19:04:40.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:3:0)
[19:04:40.158] Timer tick, asking Buildbucket for the build status
[19:04:40.557] Build 8891081074596420368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:04:40.557] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:4:0) after 1m0s
[19:05:40.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:4:0)
[19:05:40.550] Timer tick, asking Buildbucket for the build status
[19:05:40.994] Build 8891081074596420368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:05:40.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:5:0) after 1m0s
[19:06:41.094] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:5:0)
[19:06:41.094] Timer tick, asking Buildbucket for the build status
[19:06:41.812] Build 8891081074596420368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:41.812] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:6:0) after 1m0s
[19:07:09.043] Received PubSub notification, asking Buildbucket for the build status
[19:07:09.240] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:41.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:6:0)
[19:07:41.839] Timer tick, asking Buildbucket for the build status
[19:07:42.125] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:42.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:8:0) after 1m0s
[19:08:42.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:8:0)
[19:08:42.166] Timer tick, asking Buildbucket for the build status
[19:08:42.312] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:42.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:9:0) after 1m0s
[19:09:42.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:9:0)
[19:09:42.369] Timer tick, asking Buildbucket for the build status
[19:09:42.518] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:42.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:10:0) after 1m0s
[19:10:42.634] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:10:0)
[19:10:42.634] Timer tick, asking Buildbucket for the build status
[19:10:42.836] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:42.836] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:11:0) after 1m0s
[19:11:43.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:11:0)
[19:11:43.062] Timer tick, asking Buildbucket for the build status
[19:11:43.278] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:43.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:12:0) after 1m0s
[19:12:43.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:12:0)
[19:12:43.448] Timer tick, asking Buildbucket for the build status
[19:12:43.613] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:43.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:13:0) after 1m0s
[19:13:43.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:13:0)
[19:13:43.631] Timer tick, asking Buildbucket for the build status
[19:13:44.994] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:44.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:14:0) after 1m0s
[19:14:45.090] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:14:0)
[19:14:45.091] Timer tick, asking Buildbucket for the build status
[19:14:45.965] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:45.965] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:15:0) after 1m0s
[19:15:45.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:15:0)
[19:15:45.968] Timer tick, asking Buildbucket for the build status
[19:15:46.165] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:46.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:16:0) after 1m0s
[19:16:46.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:16:0)
[19:16:46.265] Timer tick, asking Buildbucket for the build status
[19:16:46.576] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:46.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:17:0) after 1m0s
[19:17:46.690] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:17:0)
[19:17:46.690] Timer tick, asking Buildbucket for the build status
[19:17:46.860] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:46.860] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:18:0) after 1m0s
[19:18:46.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:18:0)
[19:18:46.917] Timer tick, asking Buildbucket for the build status
[19:18:47.073] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:47.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:19:0) after 1m0s
[19:19:47.102] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:19:0)
[19:19:47.102] Timer tick, asking Buildbucket for the build status
[19:19:48.291] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:48.291] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:20:0) after 1m0s
[19:20:48.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:20:0)
[19:20:48.321] Timer tick, asking Buildbucket for the build status
[19:20:48.568] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:48.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:21:0) after 1m0s
[19:21:48.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:21:0)
[19:21:48.677] Timer tick, asking Buildbucket for the build status
[19:21:48.818] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:48.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:22:0) after 1m0s
[19:22:48.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:22:0)
[19:22:48.790] Timer tick, asking Buildbucket for the build status
[19:22:48.953] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:48.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:23:0) after 1m0s
[19:23:49.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:23:0)
[19:23:49.067] Timer tick, asking Buildbucket for the build status
[19:23:49.342] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:49.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:24:0) after 1m0s
[19:24:49.462] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:24:0)
[19:24:49.462] Timer tick, asking Buildbucket for the build status
[19:24:49.590] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:49.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:25:0) after 1m0s
[19:25:49.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:25:0)
[19:25:49.629] Timer tick, asking Buildbucket for the build status
[19:25:49.798] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:49.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:26:0) after 1m0s
[19:26:49.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:26:0)
[19:26:49.842] Timer tick, asking Buildbucket for the build status
[19:26:49.977] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:49.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:27:0) after 1m0s
[19:27:50.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:27:0)
[19:27:50.066] Timer tick, asking Buildbucket for the build status
[19:27:50.235] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:50.235] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:28:0) after 1m0s
[19:28:50.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:28:0)
[19:28:50.276] Timer tick, asking Buildbucket for the build status
[19:28:51.043] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:51.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:29:0) after 1m0s
[19:29:51.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:29:0)
[19:29:51.142] Timer tick, asking Buildbucket for the build status
[19:29:51.474] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:51.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:30:0) after 1m0s
[19:30:51.547] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:30:0)
[19:30:51.547] Timer tick, asking Buildbucket for the build status
[19:30:51.977] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:51.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:31:0) after 1m0s
[19:31:52.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:31:0)
[19:31:52.138] Timer tick, asking Buildbucket for the build status
[19:31:52.417] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:52.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:32:0) after 1m0s
[19:32:52.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:32:0)
[19:32:52.576] Timer tick, asking Buildbucket for the build status
[19:32:53.200] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:53.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:33:0) after 1m0s
[19:33:53.203] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:33:0)
[19:33:53.203] Timer tick, asking Buildbucket for the build status
[19:33:53.373] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:53.373] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:34:0) after 1m0s
[19:34:53.431] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:34:0)
[19:34:53.431] Timer tick, asking Buildbucket for the build status
[19:34:53.799] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:53.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:35:0) after 1m0s
[19:35:53.940] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:35:0)
[19:35:53.940] Timer tick, asking Buildbucket for the build status
[19:35:54.154] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:54.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:36:0) after 1m0s
[19:36:54.203] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:36:0)
[19:36:54.203] Timer tick, asking Buildbucket for the build status
[19:36:54.363] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:54.363] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:37:0) after 1m0s
[19:37:54.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:37:0)
[19:37:54.409] Timer tick, asking Buildbucket for the build status
[19:37:54.685] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:54.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:38:0) after 1m0s
[19:38:54.738] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:38:0)
[19:38:54.738] Timer tick, asking Buildbucket for the build status
[19:38:54.882] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:54.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:39:0) after 1m0s
[19:39:54.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:39:0)
[19:39:54.927] Timer tick, asking Buildbucket for the build status
[19:39:55.293] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:55.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:40:0) after 1m0s
[19:40:55.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:40:0)
[19:40:55.316] Timer tick, asking Buildbucket for the build status
[19:40:56.515] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:56.515] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:41:0) after 1m0s
[19:41:56.599] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:41:0)
[19:41:56.599] Timer tick, asking Buildbucket for the build status
[19:41:57.163] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:57.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:42:0) after 1m0s
[19:42:57.270] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:42:0)
[19:42:57.270] Timer tick, asking Buildbucket for the build status
[19:42:57.412] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:57.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:43:0) after 1m0s
[19:43:57.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:43:0)
[19:43:57.461] Timer tick, asking Buildbucket for the build status
[19:43:57.616] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:57.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:44:0) after 1m0s
[19:44:57.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:44:0)
[19:44:57.675] Timer tick, asking Buildbucket for the build status
[19:44:59.187] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:59.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:45:0) after 1m0s
[19:45:59.178] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:45:0)
[19:45:59.178] Timer tick, asking Buildbucket for the build status
[19:45:59.487] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:59.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:46:0) after 1m0s
[19:46:59.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:46:0)
[19:46:59.512] Timer tick, asking Buildbucket for the build status
[19:46:59.945] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:59.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:47:0) after 1m0s
[19:48:00.037] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:47:0)
[19:48:00.037] Timer tick, asking Buildbucket for the build status
[19:48:00.249] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:00.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:48:0) after 1m0s
[19:49:00.408] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:48:0)
[19:49:00.408] Timer tick, asking Buildbucket for the build status
[19:49:00.638] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:00.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:49:0) after 1m0s
[19:50:00.725] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:49:0)
[19:50:00.725] Timer tick, asking Buildbucket for the build status
[19:50:01.637] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:01.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:50:0) after 1m0s
[19:51:01.694] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:50:0)
[19:51:01.694] Timer tick, asking Buildbucket for the build status
[19:51:02.032] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:02.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:51:0) after 1m0s
[19:52:02.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:51:0)
[19:52:02.035] Timer tick, asking Buildbucket for the build status
[19:52:02.329] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:02.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:52:0) after 1m0s
[19:53:02.476] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:52:0)
[19:53:02.476] Timer tick, asking Buildbucket for the build status
[19:53:02.968] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:02.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:53:0) after 1m0s
[19:54:03.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:53:0)
[19:54:03.014] Timer tick, asking Buildbucket for the build status
[19:54:03.166] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:03.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:54:0) after 1m0s
[19:55:03.184] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:54:0)
[19:55:03.184] Timer tick, asking Buildbucket for the build status
[19:55:03.353] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:03.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:55:0) after 1m0s
[19:56:03.397] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:55:0)
[19:56:03.397] Timer tick, asking Buildbucket for the build status
[19:56:03.591] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:03.591] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:56:0) after 1m0s
[19:57:03.625] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:56:0)
[19:57:03.625] Timer tick, asking Buildbucket for the build status
[19:57:03.884] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:03.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:57:0) after 1m0s
[19:58:03.904] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:57:0)
[19:58:03.904] Timer tick, asking Buildbucket for the build status
[19:58:05.847] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:05.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:58:0) after 1m0s
[19:59:05.996] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:58:0)
[19:59:05.996] Timer tick, asking Buildbucket for the build status
[19:59:06.166] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:06.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:59:0) after 1m0s
[20:00:06.226] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:59:0)
[20:00:06.226] Timer tick, asking Buildbucket for the build status
[20:00:06.364] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:06.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:60:0) after 1m0s
[20:01:06.482] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:60:0)
[20:01:06.482] Timer tick, asking Buildbucket for the build status
[20:01:07.244] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:07.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:61:0) after 1m0s
[20:02:07.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:61:0)
[20:02:07.396] Timer tick, asking Buildbucket for the build status
[20:02:07.736] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:07.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:62:0) after 1m0s
[20:03:07.763] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:62:0)
[20:03:07.763] Timer tick, asking Buildbucket for the build status
[20:03:08.125] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:08.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:63:0) after 1m0s
[20:04:08.279] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:63:0)
[20:04:08.279] Timer tick, asking Buildbucket for the build status
[20:04:08.521] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:08.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:64:0) after 1m0s
[20:05:08.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:64:0)
[20:05:08.609] Timer tick, asking Buildbucket for the build status
[20:05:11.606] Build 8891081074596420368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:11.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056511137180405552:65:0) after 1m0s
[20:06:04.174] Received PubSub notification, asking Buildbucket for the build status
[20:06:05.165] Build 8891081074596420368: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:06:05.165] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1579205163223649",
"created_by": "project:chromium",
"created_ts": "1579201356279266",
"id": "8891081074596420368",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"97805ec6aa2332b49b72c6ff9b3b23404f1f8fb3\"}}",
"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-central1-b-8-75-j6yq\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 167460, \"got_angle_revision\": \"01c0d6bd8d7fbdfd9e4651f623860dbc41a04598\", \"got_dawn_revision\": \"631f4258a1ace016d6a10ebf7ff127ea46be8575\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"97805ec6aa2332b49b72c6ff9b3b23404f1f8fb3\", \"got_revision_cp\": \"refs/heads/master@{#732492}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"5fc197dc76693d0049d1f400a077f13fa1f6078b\", \"got_v8_revision\": \"c06633ee438bee8a915a30fdc4f9778417ccfd0f\", \"got_v8_revision_cp\": \"refs/heads/8.1.197@{#1}\", \"got_webrtc_revision\": \"6ca908f48c88fda174516ec8edc5041f61a432b2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30277}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"97805ec6aa2332b49b72c6ff9b3b23404f1f8fb3\", \"swarm_hashes_refs/heads/master(at){#732492}_without_patch\": {\"accessibility_unittests\": \"d68cee9b5b6bc1943f889252b7536bcdc37a61f4\", \"angle_unittests\": \"e9d33e099ffc8b152f10822e69bce677b4486b59\", \"app_shell_unittests\": \"ed6972790fd3af092865f8e880d4495be9cf124e\", \"aura_unittests\": \"9e60286cd731d762bd978eb2d776bcb283829878\", \"base_unittests\": \"c5753288a22fedae1a6e730cd00eeea9cad0ae14\", \"base_util_unittests\": \"a76ea7a7c1927b091a1ad0e54150a5fb1cbdb1b5\", \"blink_common_unittests\": \"c9fb191cbe61a462539f5b733f04a77704de1940\", \"blink_fuzzer_unittests\": \"cfc925ef013e02dfc1a1e633f899f6eb9a9c6a23\", \"blink_heap_unittests\": \"8283a1468e86d98dcf69a32e1ca73367b405dbf8\", \"blink_platform_unittests\": \"8d77a3159e81f7d8a753252732ee58bc8212d3ef\", \"blink_python_tests\": \"fdcffe0b1efa98e0ac0a990812ba8cfc6911a5ea\", \"blink_unittests\": \"38cbc17d13aae9488a4cd909ecbc72c45e2860d1\", \"blink_web_tests\": \"0ab3dab596c9148b564483590c9f382008b7410d\", \"boringssl_crypto_tests\": \"4c3c4afec05ab10b0490804a4b5b0692d9947748\", \"boringssl_ssl_tests\": \"68bb7f222a67b6129bf0c1f9f4887bb22f093842\", \"browser_tests\": \"760a500fe4de66c315be5a94f783fbce76bf9538\", \"cacheinvalidation_unittests\": \"a51def5b9124b27f1f8b4780397944fe68096654\", \"capture_unittests\": \"c3cc218617cdddca73db46ef7aec3b71aa0befca\", \"cast_unittests\": \"164c08188f1a87e0a6c5e7ce214b514259552a92\", \"cc_unittests\": \"f394a8c74780a236b3f4f32ef5aa0661a105cd62\", \"chrome_app_unittests\": \"9d889e25f30ce6d8507da5d4faa41ab32395ea5e\", \"chromedriver_unittests\": \"665e78ef01e68afcbae688458eebe1e157830cf8\", \"components_browsertests\": \"abdfb3bc591a84ffcf2d4256da72851b853a36fb\", \"components_unittests\": \"51c02338e142db066d18e7ff6f392c9361008d88\", \"compositor_unittests\": \"b04544edc09d58c06012525126f57cb03bec1f6b\", \"content_browsertests\": \"e6325a80b03446d0f40e920010bc210d924e8c0a\", \"content_shell_crash_test\": \"2fbfe5538a55e1106b60371d692557d0727ab270\", \"content_unittests\": \"8c34b8719d271d78c3e84bde20dc56b92630c992\", \"crashpad_tests\": \"50a2073f59a097f7569c3b93a0c53eca62065840\", \"cronet_tests\": \"fb52a2153aa7ed233690907d8a5382df0d2e2ea4\", \"cronet_unittests\": \"b1541a53181455f232077e2b526c808fbbc42e48\", \"crypto_unittests\": \"42d3e850c93c937a3503d3dcec9e7314cf4755c5\", \"dbus_unittests\": \"451f996334e1be41195b144a77c46bc973eccbd5\", \"device_unittests\": \"ab708d6cea0d2be092b0008bd1149ab527099e61\", \"display_unittests\": \"e40d9cbb5b6430172c6e61a4b3f4f4403420de2f\", \"events_unittests\": \"24139ea46423684ca6046b7bb7316162489b76bc\", \"extensions_browsertests\": \"201187ed2c5412b31b276c2335e3baef4868aab7\", \"extensions_unittests\": \"cacf32f973d62b23e3656db485556aef966454dc\", \"filesystem_service_unittests\": \"90bc39bdcd2e40e337960b12b7706d5896acfda7\", \"flatbuffers_unittests\": \"92c174f535dbe8e15f58589d59dc88efc29a10d4\", \"gcm_unit_tests\": \"4bd19e671cea63e48d0007629ee25d584085389d\", \"gfx_unittests\": \"c7cb9413f922905c0224538c4600042e1bb80083\", \"gin_unittests\": \"cb66a58a4973e9ef34be7f3bcc62b36fa68d8397\", \"google_apis_unittests\": \"70e5837d14af203311b9be9f96cac15d2271d287\", \"gpu_unittests\": \"b12c195f178b48e7dfb067b2a120fa3897c18212\", \"grit_python_unittests\": \"5ba70f2d123ffe8977591ea0b82d6185e7fe166f\", \"gwp_asan_unittests\": \"dda129a7d9018981ea88bf49d74f589fb34c5fec\", \"headless_browsertests\": \"2d861f72b261184045dc3838e45014fbbf757151\", \"headless_unittests\": \"38a3e6f5451cab885f6036a1d160df4d3ed198cc\", \"interactive_ui_tests\": \"a79b6116149b05827f4880b0efee1827348b53a0\", \"ipc_tests\": \"10f54d8155c6fbabf1b92950a16b31c2dc6d3f38\", \"jingle_unittests\": \"a18fda064e6f823f738a13f70e09addc48cdb37a\", \"latency_unittests\": \"7c4dc0b5032307d61f1a379cb3cd58a5f39d7e1a\", \"libjingle_xmpp_unittests\": \"3d7572181ccb864fc5435f2cc22f87c63e67f17b\", \"media_blink_unittests\": \"7335bcf745b677cbcd2e9a7a0a703fb76a892567\", \"media_service_unittests\": \"91596fa8b84181704972fef1d7a33eadd54332fa\", \"media_unittests\": \"d282f68e880d515a6876adb9a61c6fe37c6194c0\", \"message_center_unittests\": \"ab399b05879732c106ee0e3eaddc39c0eaef1819\", \"metrics_python_tests\": \"738cc66a7be91c0b007977a8f660f36ca85b7807\", \"midi_unittests\": \"1b18dfdf213337f5ea90ecbec94cc4bf37a7e5f1\", \"mojo_core_unittests\": \"012cac42bb7a5dc92cbfa1c6e57eff86a8ecd6c4\", \"mojo_unittests\": \"dad243832781758807e4130c6dc887f2e343bad0\", \"nacl_helper_nonsfi_unittests\": \"888778c6ff3bbc443376c83a5ac79b01c33ba57a\", \"nacl_loader_unittests\": \"f4bd086a7d347a8b3d4445b17267ef88ea11a701\", \"native_theme_unittests\": \"83b1b6012ad24e4785171111b1db70bf42bbc6b4\", \"net_unittests\": \"b7a19d21035637724b05b99ea10324d22d08aa2f\", \"pdf_unittests\": \"79d3dee80fff181c04b6d8604c9001ae9efe1052\", \"perfetto_unittests\": \"46c5924efb16d9bcd042c71ad2c74d00f82df4d2\", \"ppapi_unittests\": \"1fbd30772bb114bf1dff3a0721ffaa095c3215c3\", \"printing_unittests\": \"7da2d819a086fa8b5a7bab75cda22c5bbea26655\", \"remoting_unittests\": \"101717de69edc722ee4b6dece33638e56f8e9bc8\", \"sandbox_linux_unittests\": \"3f7cae238dd722bdbf467b0ba068da1797d8aa09\", \"service_manager_unittests\": \"ea821748eb6d60286d4429b524e2c200f42047bb\", \"services_unittests\": \"aa505efb8ed9d02c0b66ae7b929049bf6491571d\", \"shell_dialogs_unittests\": \"a3d3a716114794c86e9d4f14568bd2ce9aa93cac\", \"skia_unittests\": \"8269e0a156694d73ccccc7467c8a348342bbaa64\", \"snapshot_unittests\": \"565d5cf7ac21d9d118021154f16561b2ee0033e0\", \"sql_unittests\": \"5059eb49fc49a1d317d99ec7a4e08258d0ab5769\", \"storage_unittests\": \"786928ea5b8c353580b50d82df84e445406f4817\", \"sync_integration_tests\": \"249f3717baf3472d2bff0d1de55947eb667f6fba\", \"telemetry_gpu_unittests\": \"778fc40f4ef26f3b4aae0a8e22f071cdb93020f6\", \"telemetry_perf_unittests\": \"41c553e81d1f75cd053f31e97cd24894465bee02\", \"telemetry_unittests\": \"202696a2339cb9fb92198409a1408460d49a2790\", \"traffic_annotation_auditor_unittests\": \"3307b5ace7fefa647d32c061f08011eb02646a62\", \"ui_base_unittests\": \"023f54fd156709c73846147b5e100400598b3d6c\", \"ui_touch_selection_unittests\": \"3396f2c9580479cc77d9e55b7f523b449e82e58d\", \"unit_tests\": \"af1daca4ae498c6958ec36b502f42964d9a337a6\", \"url_unittests\": \"ea18bd0f5f77c49c80e1b777967cc39b93b24d00\", \"views_perftests\": \"07473c234e4ba88163b922cae07ed34e4441dc47\", \"views_unittests\": \"52539a119300cee445bb7f359050e64f65efc237\", \"viz_unittests\": \"b405a55d267de7cb308df665202497f3ae8d16b4\", \"vr_common_unittests\": \"d140aff4b0a1146efc92f9c997eebd7fe3c995dc\", \"vr_pixeltests\": \"34d0751701f74b36e9043428843400acf7c74f51\", \"webdriver_wpt_tests\": \"d7122d0033af302de1397227ce0fe79f515683df\", \"weblayer_browsertests\": \"1e47d6d422958555a7ddab744fcfb003bd5e5ca2\", \"wm_unittests\": \"1bbe5d41a0f43819d0d0345fe1f51bcfa4253a72\", \"wtf_unittests\": \"5c79226295ded59466b534998d2060b3cd26d0ef\", \"xr_browser_tests\": \"c2379f9a4c765cc4afa1278f1b0a18b3bf580ef6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_53a0dbabd2cebac1b8e64bcbfab336eb0021d1dc40b2d4ba5321eb0a070d508c_v2\", \"builder_b113f2ba74b645396d20a53e30fea3b3f4dbe0717301c9938984732251717657_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-75-j6yq\"], \"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-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1579201628428484",
"status": "COMPLETED",
"status_changed_ts": "1579205163615337",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167460",
"builder:Linux Builder (dbg)",
"buildset:commit/git/97805ec6aa2332b49b72c6ff9b3b23404f1f8fb3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97805ec6aa2332b49b72c6ff9b3b23404f1f8fb3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056511137180405552",
"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/8891081074596420368/+/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:49c88df66aff4810",
"user_agent:luci-scheduler"
],
"updated_ts": "1579205163619467",
"url": "https://ci.chromium.org/b/8891081074596420368",
"utcnow_ts": "1579205165140024"
}
}
[20:06:05.165] Invocation finished in 1h3m30.734069975s with status SUCCEEDED