[22:58:24.394] New invocation is queued and will start shortly
[22:58:25.493] Starting the invocation (attempt 1)
[22:58:25.542] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:58:25.542] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:58:25.542] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9060482566411787744",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c42546c0dc8e3f8a44c647fd166bf668d0fea462\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9060482566411787744",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/c42546c0dc8e3f8a44c647fd166bf668d0fea462",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c42546c0dc8e3f8a44c647fd166bf668d0fea462",
"gitiles_ref:refs/heads/master"
]
}
[22:58:27.187] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1575413905827985",
"id": "8895052504241705872",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c42546c0dc8e3f8a44c647fd166bf668d0fea462\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1575413906669693",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165616",
"builder:Linux Builder (dbg)",
"buildset:commit/git/c42546c0dc8e3f8a44c647fd166bf668d0fea462",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c42546c0dc8e3f8a44c647fd166bf668d0fea462",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060482566411787744",
"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/8895052504241705872/+/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": "1575413906669873",
"url": "https://ci.chromium.org/b/8895052504241705872",
"utcnow_ts": "1575413907174808"
}
}
[22:58:27.187] Task URL: https://ci.chromium.org/b/8895052504241705872
[22:58:27.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:2:0) after 1m0s
[22:59:27.253] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:2:0)
[22:59:27.253] Timer tick, asking Buildbucket for the build status
[22:59:27.435] Build 8895052504241705872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:27.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:3:0) after 1m0s
[22:59:51.672] Received PubSub notification, asking Buildbucket for the build status
[22:59:51.904] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:27.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:3:0)
[23:00:27.542] Timer tick, asking Buildbucket for the build status
[23:00:28.034] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:28.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:5:0) after 1m0s
[23:01:28.440] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:5:0)
[23:01:28.440] Timer tick, asking Buildbucket for the build status
[23:01:31.364] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:31.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:6:0) after 1m0s
[23:02:31.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:6:0)
[23:02:31.551] Timer tick, asking Buildbucket for the build status
[23:02:32.748] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:32.748] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:7:0) after 1m0s
[23:03:33.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:7:0)
[23:03:33.351] Timer tick, asking Buildbucket for the build status
[23:03:33.818] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:33.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:8:0) after 1m0s
[23:04:34.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:8:0)
[23:04:34.341] Timer tick, asking Buildbucket for the build status
[23:04:34.619] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:34.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:9:0) after 1m0s
[23:05:35.044] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:9:0)
[23:05:35.044] Timer tick, asking Buildbucket for the build status
[23:05:36.248] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:36.248] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:10:0) after 1m0s
[23:06:36.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:10:0)
[23:06:36.294] Timer tick, asking Buildbucket for the build status
[23:06:37.112] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:37.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:11:0) after 1m0s
[23:07:37.191] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:11:0)
[23:07:37.191] Timer tick, asking Buildbucket for the build status
[23:07:37.418] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:37.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:12:0) after 1m0s
[23:08:37.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:12:0)
[23:08:37.488] Timer tick, asking Buildbucket for the build status
[23:08:38.457] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:38.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:13:0) after 1m0s
[23:09:38.527] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:13:0)
[23:09:38.527] Timer tick, asking Buildbucket for the build status
[23:09:39.267] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:39.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:14:0) after 1m0s
[23:10:39.376] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:14:0)
[23:10:39.376] Timer tick, asking Buildbucket for the build status
[23:10:39.545] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:39.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:15:0) after 1m0s
[23:11:39.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:15:0)
[23:11:39.523] Timer tick, asking Buildbucket for the build status
[23:11:39.691] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:39.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:16:0) after 1m0s
[23:12:39.776] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:16:0)
[23:12:39.776] Timer tick, asking Buildbucket for the build status
[23:12:40.011] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:40.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:17:0) after 1m0s
[23:13:40.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:17:0)
[23:13:40.052] Timer tick, asking Buildbucket for the build status
[23:13:41.066] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:41.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:18:0) after 1m0s
[23:14:41.094] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:18:0)
[23:14:41.094] Timer tick, asking Buildbucket for the build status
[23:14:42.374] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:42.374] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:19:0) after 1m0s
[23:15:42.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:19:0)
[23:15:42.520] Timer tick, asking Buildbucket for the build status
[23:15:43.046] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:43.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:20:0) after 1m0s
[23:16:43.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:20:0)
[23:16:43.164] Timer tick, asking Buildbucket for the build status
[23:16:43.491] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:43.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:21:0) after 1m0s
[23:17:43.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:21:0)
[23:17:43.576] Timer tick, asking Buildbucket for the build status
[23:17:44.294] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:44.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:22:0) after 1m0s
[23:18:44.443] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:22:0)
[23:18:44.443] Timer tick, asking Buildbucket for the build status
[23:18:45.264] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:45.264] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:23:0) after 1m0s
[23:19:45.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:23:0)
[23:19:45.351] Timer tick, asking Buildbucket for the build status
[23:19:46.395] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:46.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:24:0) after 1m0s
[23:20:46.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:24:0)
[23:20:46.401] Timer tick, asking Buildbucket for the build status
[23:20:46.571] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:46.571] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:25:0) after 1m0s
[23:21:46.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:25:0)
[23:21:46.674] Timer tick, asking Buildbucket for the build status
[23:21:46.965] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:46.965] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:26:0) after 1m0s
[23:22:47.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:26:0)
[23:22:47.027] Timer tick, asking Buildbucket for the build status
[23:22:47.183] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:47.183] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:27:0) after 1m0s
[23:23:47.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:27:0)
[23:23:47.292] Timer tick, asking Buildbucket for the build status
[23:23:47.763] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:47.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:28:0) after 1m0s
[23:24:47.818] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:28:0)
[23:24:47.818] Timer tick, asking Buildbucket for the build status
[23:24:47.974] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:47.974] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:29:0) after 1m0s
[23:25:47.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:29:0)
[23:25:47.981] Timer tick, asking Buildbucket for the build status
[23:25:48.196] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:48.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:30:0) after 1m0s
[23:26:48.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:30:0)
[23:26:48.553] Timer tick, asking Buildbucket for the build status
[23:26:49.467] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:49.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:31:0) after 1m0s
[23:27:49.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:31:0)
[23:27:49.803] Timer tick, asking Buildbucket for the build status
[23:27:50.548] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:50.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:32:0) after 1m0s
[23:28:50.737] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:32:0)
[23:28:50.737] Timer tick, asking Buildbucket for the build status
[23:28:51.454] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:51.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:33:0) after 1m0s
[23:29:51.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:33:0)
[23:29:51.497] Timer tick, asking Buildbucket for the build status
[23:29:51.734] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:51.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:34:0) after 1m0s
[23:30:52.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:34:0)
[23:30:52.036] Timer tick, asking Buildbucket for the build status
[23:30:52.435] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:52.435] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:35:0) after 1m0s
[23:31:52.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:35:0)
[23:31:52.598] Timer tick, asking Buildbucket for the build status
[23:31:54.317] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:54.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:36:0) after 1m0s
[23:32:58.315] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:36:0)
[23:32:58.315] Timer tick, asking Buildbucket for the build status
[23:32:59.031] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:59.031] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:37:0) after 1m0s
[23:33:59.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:37:0)
[23:33:59.484] Timer tick, asking Buildbucket for the build status
[23:33:59.728] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:59.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:38:0) after 1m0s
[23:35:00.290] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:38:0)
[23:35:00.290] Timer tick, asking Buildbucket for the build status
[23:35:01.025] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:01.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:39:0) after 1m0s
[23:36:01.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:39:0)
[23:36:01.835] Timer tick, asking Buildbucket for the build status
[23:36:02.214] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:02.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:40:0) after 1m0s
[23:37:02.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:40:0)
[23:37:02.573] Timer tick, asking Buildbucket for the build status
[23:37:02.742] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:02.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:41:0) after 1m0s
[23:38:02.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:41:0)
[23:38:02.974] Timer tick, asking Buildbucket for the build status
[23:38:03.178] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:03.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:42:0) after 1m0s
[23:39:03.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:42:0)
[23:39:03.512] Timer tick, asking Buildbucket for the build status
[23:39:04.290] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:04.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:43:0) after 1m0s
[23:40:04.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:43:0)
[23:40:04.742] Timer tick, asking Buildbucket for the build status
[23:40:05.109] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:05.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:44:0) after 1m0s
[23:41:06.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:44:0)
[23:41:06.711] Timer tick, asking Buildbucket for the build status
[23:41:08.941] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:08.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:45:0) after 1m0s
[23:42:09.557] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:45:0)
[23:42:09.557] Timer tick, asking Buildbucket for the build status
[23:42:09.691] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:09.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:46:0) after 1m0s
[23:43:09.781] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:46:0)
[23:43:09.781] Timer tick, asking Buildbucket for the build status
[23:43:10.003] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:10.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:47:0) after 1m0s
[23:44:10.044] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:47:0)
[23:44:10.044] Timer tick, asking Buildbucket for the build status
[23:44:10.337] Build 8895052504241705872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:10.337] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060482566411787744:48:0) after 1m0s
[23:44:42.474] Received PubSub notification, asking Buildbucket for the build status
[23:44:42.636] Build 8895052504241705872: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:44:42.636] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1575416681683321",
"created_by": "project:chromium",
"created_ts": "1575413905827985",
"id": "8895052504241705872",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c42546c0dc8e3f8a44c647fd166bf668d0fea462\"}}",
"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-5-n2ro\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 165616, \"got_angle_revision\": \"fc2dd45054bf8478522e43f7d86f5e328833fdf9\", \"got_dawn_revision\": \"be5c135672275b2f7907d7ce3be471d1800b8408\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"c42546c0dc8e3f8a44c647fd166bf668d0fea462\", \"got_revision_cp\": \"refs/heads/master@{#721210}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"8ffeadb66ea7f6dc69310642a78b0c5c85ca57f6\", \"got_v8_revision\": \"adfb6ba32d881a5bba73f9c7121ca9f8dba881b4\", \"got_v8_revision_cp\": \"refs/heads/8.0.418@{#1}\", \"got_webrtc_revision\": \"89313451d8e2338845716b0ab8760ed0552580f9\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29962}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c42546c0dc8e3f8a44c647fd166bf668d0fea462\", \"swarm_hashes_refs/heads/master(at){#721210}_without_patch\": {\"accessibility_unittests\": \"e5b18d2bb7213d9509a0cfbad5dcd68c005110b9\", \"angle_unittests\": \"0d171b1d3b4f0c24079524e01e8b8d60d3d75026\", \"app_shell_unittests\": \"3594339a308d4a5c19c4c34a144a470174d2ae57\", \"aura_unittests\": \"6fb73da1cda4772ac6a42b866b4617fcbf546ef5\", \"base_unittests\": \"ef64f7592a285dc36a85f4066fc82d114224c79d\", \"base_util_unittests\": \"59408466a67c2a701a2e8dd2f4d2b6c7c77c5412\", \"blink_common_unittests\": \"e2e774ac51948a641dceb1cc9d8950338b06b889\", \"blink_fuzzer_unittests\": \"cfef3dba727d6527356791bb765d05d9c7734175\", \"blink_heap_unittests\": \"ab3884c175eacd60192b4e1a1a4fa67e074e7b3b\", \"blink_platform_unittests\": \"211168983be3886c4b3b726b5e71e897f4a9ac68\", \"blink_python_tests\": \"69f8bde270eddd7e0925029296f4473d70a4d5ad\", \"blink_unittests\": \"c126fb9b0af1100cdae588c06c399a81252a2793\", \"blink_web_tests_exparchive\": \"dbd78d3ee66ef8eb08ea611d026a14e9fc36ba99\", \"boringssl_crypto_tests\": \"8de33ecd53e10b2daa1a5932a8bcc1e8c1739166\", \"boringssl_ssl_tests\": \"1335b42f9ce5e5155124ded8678cb6c318bfdd5c\", \"browser_tests\": \"d88f6764eca43f3137d782346250d67fdcb392e0\", \"cacheinvalidation_unittests\": \"1c7330b9f502745274b5a05ac0f6708353769baf\", \"capture_unittests\": \"a57fa863b2b3ae69f0922f7d3010abf4a7b3578c\", \"cast_unittests\": \"9f3a1cd04f04e23d0151cef7b3ce596916c26da0\", \"cc_unittests\": \"3c02af5a683c9f5da8f815feeca8e4240076ca68\", \"chrome_app_unittests\": \"e161e531a8251c82271a0f10f8daf7d0b9549aa1\", \"chromedriver_unittests\": \"541b5a4eb042fbbf907d7946592b4ca681ac75fc\", \"color_unittests\": \"e3f81c1495ed309e18d273cfdaedc7bb1c2aa530\", \"components_browsertests\": \"df86ab8692775d6c417c9a97a6fbc2cf6e507ab5\", \"components_unittests\": \"0d95ec4c6379525dd8dccbd62a5ca79908b7071e\", \"compositor_unittests\": \"d9b526f3b91dddac7a6dcac53feb8d85c0debd13\", \"content_browsertests\": \"22f62a5a106299b09e39301f88a48684bb3e19ef\", \"content_shell_crash_test\": \"89f9d8be7bda2ffce9a698a79d0d34949b3664d2\", \"content_unittests\": \"158de6fd32b4d989a487eec84bab815b03a49a47\", \"crashpad_tests\": \"d21b312ccbd8caa24cd2a87a3c9ce25207658a1e\", \"cronet_tests\": \"7573f11e30c577bad8b8c801779a2eb4213086a9\", \"cronet_unittests\": \"82e8ce66c41efb7cd0895fd30582a1bbd9317bbd\", \"crypto_unittests\": \"65f79690572ec5df1e7584465b30f4404b036605\", \"dbus_unittests\": \"938b56a715b7a0eb2fb22ee0dba534813cf34c4f\", \"device_unittests\": \"1172a3b7141ab74c4766fd332144eac0784494b8\", \"devtools_lint_check\": \"d4569f729ec7dfedf9471bd7141505803d6edd32\", \"devtools_type_check\": \"07c847e65cec8599681255547909941a257a17f7\", \"display_unittests\": \"8cb253626b4ee0f668143218e2bee27d766007a7\", \"events_unittests\": \"a751381ee1261ad59e0cce0642a8ce60aaef1c38\", \"extensions_browsertests\": \"21a882297d4a2d44b67cebe886fabe32af783f62\", \"extensions_unittests\": \"6306a99e6ec5e69d4ade14a418650dc6bd3447df\", \"filesystem_service_unittests\": \"8c7cba7218e75ea37b85e689770483a6391bba58\", \"flatbuffers_unittests\": \"87cf3d4f1486d42f8595ee02362ad0fa22286571\", \"gcm_unit_tests\": \"b43005e9c568c9de424f79e92c21fd6fd7bfea52\", \"gfx_unittests\": \"e40ff318b6692d92bd2295d82f44a52be516b233\", \"gin_unittests\": \"7ecf13491ee913fc560b067e7d7c541e1b5b15ba\", \"google_apis_unittests\": \"a2f12633adcd92881b89da9d019b15d6ec23afa5\", \"gpu_unittests\": \"7e911458571dc4583bbc53775e1eced4e564e38a\", \"grit_python_unittests\": \"e63c825e2bc8b1d341a853f965d6a4f9c0d6c54f\", \"gwp_asan_unittests\": \"4c990c75f83c8569ae82e1939931a58cdbb173f5\", \"headless_browsertests\": \"0cc3b68938d6b14f1faa9ac6764fb6baee6c88d3\", \"headless_unittests\": \"24a3a2d4929696da72fb37e21858620643f1c89c\", \"interactive_ui_tests\": \"63b9aa95f8d1179d56f8731df298e4a2ebe2376b\", \"ipc_tests\": \"3b0d81f5abba9d466c4f689067bed6d618a1d886\", \"jingle_unittests\": \"02408a0533f506d709b62ce438cb75ec513953d2\", \"latency_unittests\": \"3dbe68a9e37df013b6374ba7c67c53fb5b50b024\", \"libjingle_xmpp_unittests\": \"7738b3c7ba095317060a0d5062df288afedd548e\", \"media_blink_unittests\": \"35fe7b72b7ee3f487cbad316630910e601c693f5\", \"media_service_unittests\": \"3fffe61daf85e3b306eb30f8b8b7f42e35de99b9\", \"media_unittests\": \"1ae79622aa88e9bd279a141691da5860771e669e\", \"message_center_unittests\": \"b18df9ca3f457e3189dc3b2d04758aa99519701b\", \"metrics_python_tests\": \"8912355bc31e42ac328ebe39619c593fc22dbc29\", \"midi_unittests\": \"9feeeec399183b9dbe953546e3bd32c9c1ecd712\", \"mojo_core_unittests\": \"a5220baad927fdddd6afd4cccdc15f57b46a86ad\", \"mojo_unittests\": \"d57491f0028fef0298199e282027acea1af1abff\", \"nacl_helper_nonsfi_unittests\": \"21cef45f4935d29581dd5dc022f4ccbc37433d64\", \"nacl_loader_unittests\": \"f0cf44f10f21098cfc030c9fa9910f62fe4daa7e\", \"native_theme_unittests\": \"cdcb32784237484705dbc233c92947d5e16cf0a7\", \"net_unittests\": \"7330f46c49b40a1583b7e59dca04d7b6ee3bdd95\", \"pdf_unittests\": \"3a19992663ac8ceb57580dea8a99f2c10c8e28c9\", \"perfetto_unittests\": \"7782da0c9a56a53dccb061178fc9384f0903cba1\", \"ppapi_unittests\": \"a9402e7a7585f67edf933f5f269777861530233a\", \"printing_unittests\": \"5e56a09962c634a3cd4b946b0f2bf2c0b0c13c13\", \"remoting_unittests\": \"9c14a69bc97b20d66f5c6b293e79e6af0ad42ab0\", \"sandbox_linux_unittests\": \"a00cd644d0d0b0d6e43da55d472f682574c85d4c\", \"service_manager_unittests\": \"7438b80a324d46027ea11e3f0e77e0b0185669ed\", \"services_unittests\": \"3f1c9fbcefb887a92ead17080b7cd489c2d25a66\", \"shell_dialogs_unittests\": \"0fb1d052754e30ea25533070a36aacc36fa58085\", \"skia_unittests\": \"f9bf06692ca7090e5d26732b969e00e93878f973\", \"snapshot_unittests\": \"d34d4a68b0603678ea490798acf753e92aa076c4\", \"sql_unittests\": \"a842c3b221bf150337e6361892b1a2679606134c\", \"storage_unittests\": \"2a2a879724425a19a4baf9b2f2182b08c699b891\", \"sync_integration_tests\": \"e95579dd6a4afa3293814237c8b5495405a868b3\", \"telemetry_gpu_unittests\": \"b35c9a18edfc2f09fbecb5eae9b251f9f1f1820a\", \"telemetry_perf_unittests\": \"a206a0bcf065f7b673c81893cae86e7f0bd9438a\", \"telemetry_unittests\": \"ea74343268d989c57c283ff366049122e866f913\", \"traffic_annotation_auditor_unittests\": \"9410fe971504f724c60eb4a74669d670e2095159\", \"ui_base_unittests\": \"3858461556e272acdd5dfccee6fb83a123f6c303\", \"ui_touch_selection_unittests\": \"0c9759b45aa687fc21dce8042606b3a811341f29\", \"unit_tests\": \"ee27c522ccfc49f8a836be29c7a1e52ea3c590a2\", \"url_unittests\": \"5e935243d11094febf9fcc0a5cd14af38f329401\", \"views_perftests\": \"b885b29f3ddebf4b9f469eefac86397ddd0e0d50\", \"views_unittests\": \"8e0e15458c2bdb3377faa179da8bce924bd6b78e\", \"viz_unittests\": \"9bac4e68af2baef6239e2943ee16364871a9751f\", \"vr_common_unittests\": \"312be61380a3387f4dfee7025e53909733cc875f\", \"vr_pixeltests\": \"13b9e0b7caef4be95d2bb744ba71f60d826b6311\", \"webdriver_wpt_tests\": \"02f2f3b4bc02a22e5ae6df94b709917771f92f7a\", \"weblayer_browsertests\": \"c3f9906d3e8df624e922824d84559c17b94fd5e0\", \"wm_unittests\": \"992a0da37555d63454444bd4b39356ee60b52b90\", \"wtf_unittests\": \"59671eaa1a4d394db186ab4c87b59189576f6f47\", \"xr_browser_tests\": \"6da33ecf1eeeae3e86462d7882b1ce3d64a4df8f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1313787165392eb219c57f145b1b9e0fbbb62d544385caa60e27617303515107_v2\", \"builder_3b404fa22a3c1a181985100df1a34c166b035b5f7265e772f51e56790f9dc011_v2\", \"builder_544ce64b59aa2a62f93b2d1058d8c643105c17650fa0dc2da4c94ddccafb95f6_v2\", \"builder_8851890e994e29b56fba2042f90feba99073c8e56d0ea67af5ee13ebe9f87cf6_v2\", \"builder_ce52aa3ab9d9a450d9b5f3fb151dc5a055ee991845b7d9f6a360be4cd1eb07f1_v2\", \"builder_dbb86507a6c3fadd4cf4e1827f5f960c6207016e30a949100a00998d3583e722_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-5-n2ro\"], \"image\": [\"chrome-xenial-19112404-1fe53dcaaf2\"], \"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\": [\"4679-6acb960\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1575413990903349",
"status": "COMPLETED",
"status_changed_ts": "1575416682102579",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165616",
"builder:Linux Builder (dbg)",
"buildset:commit/git/c42546c0dc8e3f8a44c647fd166bf668d0fea462",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c42546c0dc8e3f8a44c647fd166bf668d0fea462",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060482566411787744",
"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/8895052504241705872/+/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:48e6ce5345490610",
"user_agent:luci-scheduler"
],
"updated_ts": "1575416682109394",
"url": "https://ci.chromium.org/b/8895052504241705872",
"utcnow_ts": "1575416682617768"
}
}
[23:44:42.636] Invocation finished in 46m18.26208051s with status SUCCEEDED