[20:23:22.382] New invocation is queued and will start shortly
[20:23:26.731] Starting the invocation (attempt 1)
[20:23:26.793] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:23:26.793] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:23:26.793] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9061579483871007328",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4d4e06ddc3b2804340f343e0551076ae25f06941\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9061579483871007328",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/4d4e06ddc3b2804340f343e0551076ae25f06941",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d4e06ddc3b2804340f343e0551076ae25f06941",
"gitiles_ref:refs/heads/master"
]
}
[20:23:28.185] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1574367807005981",
"id": "8896149418360190528",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4d4e06ddc3b2804340f343e0551076ae25f06941\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1574367807780318",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165121",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4d4e06ddc3b2804340f343e0551076ae25f06941",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d4e06ddc3b2804340f343e0551076ae25f06941",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061579483871007328",
"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/8896149418360190528/+/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": "1574367807780492",
"url": "https://ci.chromium.org/b/8896149418360190528",
"utcnow_ts": "1574367808172093"
}
}
[20:23:28.185] Task URL: https://ci.chromium.org/b/8896149418360190528
[20:23:28.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:2:0) after 1m0s
[20:24:28.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:2:0)
[20:24:28.575] Timer tick, asking Buildbucket for the build status
[20:24:28.847] Build 8896149418360190528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:24:28.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:3:0) after 1m0s
[20:24:41.556] Received PubSub notification, asking Buildbucket for the build status
[20:24:42.365] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:29.616] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:3:0)
[20:25:29.616] Timer tick, asking Buildbucket for the build status
[20:25:29.941] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:29.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:5:0) after 1m0s
[20:26:30.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:5:0)
[20:26:30.224] Timer tick, asking Buildbucket for the build status
[20:26:30.821] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:30.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:6:0) after 1m0s
[20:27:31.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:6:0)
[20:27:31.323] Timer tick, asking Buildbucket for the build status
[20:27:31.786] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:31.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:7:0) after 1m0s
[20:28:32.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:7:0)
[20:28:32.257] Timer tick, asking Buildbucket for the build status
[20:28:33.171] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:33.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:8:0) after 1m0s
[20:29:33.398] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:8:0)
[20:29:33.398] Timer tick, asking Buildbucket for the build status
[20:29:33.552] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:33.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:9:0) after 1m0s
[20:30:33.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:9:0)
[20:30:33.624] Timer tick, asking Buildbucket for the build status
[20:30:33.764] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:33.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:10:0) after 1m0s
[20:31:34.399] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:10:0)
[20:31:34.399] Timer tick, asking Buildbucket for the build status
[20:31:34.699] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:34.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:11:0) after 1m0s
[20:32:35.263] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:11:0)
[20:32:35.263] Timer tick, asking Buildbucket for the build status
[20:32:36.707] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:36.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:12:0) after 1m0s
[20:33:36.738] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:12:0)
[20:33:36.738] Timer tick, asking Buildbucket for the build status
[20:33:39.044] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:39.044] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:13:0) after 1m0s
[20:34:39.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:13:0)
[20:34:39.297] Timer tick, asking Buildbucket for the build status
[20:34:39.463] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:39.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:14:0) after 1m0s
[20:35:39.734] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:14:0)
[20:35:39.734] Timer tick, asking Buildbucket for the build status
[20:35:40.381] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:40.381] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:15:0) after 1m0s
[20:36:40.597] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:15:0)
[20:36:40.597] Timer tick, asking Buildbucket for the build status
[20:36:40.895] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:40.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:16:0) after 1m0s
[20:37:41.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:16:0)
[20:37:41.072] Timer tick, asking Buildbucket for the build status
[20:37:41.711] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:41.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:17:0) after 1m0s
[20:38:41.831] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:17:0)
[20:38:41.831] Timer tick, asking Buildbucket for the build status
[20:38:42.387] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:42.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:18:0) after 1m0s
[20:39:42.458] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:18:0)
[20:39:42.458] Timer tick, asking Buildbucket for the build status
[20:39:42.664] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:42.664] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:19:0) after 1m0s
[20:40:42.770] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:19:0)
[20:40:42.770] Timer tick, asking Buildbucket for the build status
[20:40:42.989] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:42.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:20:0) after 1m0s
[20:41:43.011] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:20:0)
[20:41:43.011] Timer tick, asking Buildbucket for the build status
[20:41:43.480] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:43.480] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:21:0) after 1m0s
[20:42:43.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:21:0)
[20:42:43.517] Timer tick, asking Buildbucket for the build status
[20:42:43.815] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:43.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:22:0) after 1m0s
[20:43:43.808] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:22:0)
[20:43:43.808] Timer tick, asking Buildbucket for the build status
[20:43:44.004] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:44.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:23:0) after 1m0s
[20:44:44.049] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:23:0)
[20:44:44.049] Timer tick, asking Buildbucket for the build status
[20:44:44.343] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:44.343] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:24:0) after 1m0s
[20:45:44.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:24:0)
[20:45:44.550] Timer tick, asking Buildbucket for the build status
[20:45:46.947] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:46.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:25:0) after 1m0s
[20:46:47.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:25:0)
[20:46:47.067] Timer tick, asking Buildbucket for the build status
[20:46:47.634] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:47.634] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:26:0) after 1m0s
[20:47:47.712] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:26:0)
[20:47:47.712] Timer tick, asking Buildbucket for the build status
[20:47:47.990] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:47.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:27:0) after 1m0s
[20:48:48.118] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:27:0)
[20:48:48.118] Timer tick, asking Buildbucket for the build status
[20:48:48.350] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:48.350] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:28:0) after 1m0s
[20:49:48.377] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:28:0)
[20:49:48.377] Timer tick, asking Buildbucket for the build status
[20:49:48.631] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:48.631] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:29:0) after 1m0s
[20:50:48.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:29:0)
[20:50:48.632] Timer tick, asking Buildbucket for the build status
[20:50:49.773] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:49.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:30:0) after 1m0s
[20:51:49.850] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:30:0)
[20:51:49.850] Timer tick, asking Buildbucket for the build status
[20:51:50.371] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:50.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:31:0) after 1m0s
[20:52:50.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:31:0)
[20:52:50.414] Timer tick, asking Buildbucket for the build status
[20:52:51.500] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:51.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:32:0) after 1m0s
[20:53:51.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:32:0)
[20:53:51.535] Timer tick, asking Buildbucket for the build status
[20:53:52.197] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:52.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:33:0) after 1m0s
[20:54:52.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:33:0)
[20:54:52.257] Timer tick, asking Buildbucket for the build status
[20:54:52.866] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:52.866] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:34:0) after 1m0s
[20:55:52.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:34:0)
[20:55:52.977] Timer tick, asking Buildbucket for the build status
[20:55:53.321] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:53.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:35:0) after 1m0s
[20:56:53.462] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:35:0)
[20:56:53.462] Timer tick, asking Buildbucket for the build status
[20:56:53.705] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:53.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:36:0) after 1m0s
[20:57:53.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:36:0)
[20:57:53.801] Timer tick, asking Buildbucket for the build status
[20:57:54.392] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:54.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:37:0) after 1m0s
[20:58:54.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:37:0)
[20:58:54.480] Timer tick, asking Buildbucket for the build status
[20:58:55.206] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:55.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:38:0) after 1m0s
[20:59:55.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:38:0)
[20:59:55.450] Timer tick, asking Buildbucket for the build status
[20:59:57.975] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:57.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:39:0) after 1m0s
[21:00:58.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:39:0)
[21:00:58.137] Timer tick, asking Buildbucket for the build status
[21:00:58.611] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:58.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:40:0) after 1m0s
[21:01:58.669] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:40:0)
[21:01:58.669] Timer tick, asking Buildbucket for the build status
[21:01:59.694] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:59.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:41:0) after 1m0s
[21:02:59.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:41:0)
[21:02:59.753] Timer tick, asking Buildbucket for the build status
[21:03:00.674] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:00.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:42:0) after 1m0s
[21:04:00.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:42:0)
[21:04:00.716] Timer tick, asking Buildbucket for the build status
[21:04:01.177] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:01.177] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:43:0) after 1m0s
[21:05:01.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:43:0)
[21:05:01.265] Timer tick, asking Buildbucket for the build status
[21:05:01.441] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:01.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:44:0) after 1m0s
[21:06:01.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:44:0)
[21:06:01.528] Timer tick, asking Buildbucket for the build status
[21:06:02.036] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:02.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:45:0) after 1m0s
[21:07:02.088] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:45:0)
[21:07:02.088] Timer tick, asking Buildbucket for the build status
[21:07:02.517] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:02.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:46:0) after 1m0s
[21:08:02.623] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:46:0)
[21:08:02.623] Timer tick, asking Buildbucket for the build status
[21:08:02.921] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:02.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:47:0) after 1m0s
[21:09:03.047] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:47:0)
[21:09:03.047] Timer tick, asking Buildbucket for the build status
[21:09:03.378] Build 8896149418360190528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:03.378] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061579483871007328:48:0) after 1m0s
[21:09:35.850] Received PubSub notification, asking Buildbucket for the build status
[21:09:36.737] Build 8896149418360190528: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:09:36.737] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1574370574942854",
"created_by": "project:chromium",
"created_ts": "1574367807005981",
"id": "8896149418360190528",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4d4e06ddc3b2804340f343e0551076ae25f06941\"}}",
"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-7-a26u\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 165121, \"got_angle_revision\": \"b0a9de95128d9a97995b59db5a0c6386c56e051e\", \"got_dawn_revision\": \"0d4a7b0ba5b73425c1c5aa641843f971f0bdda4d\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"4d4e06ddc3b2804340f343e0551076ae25f06941\", \"got_revision_cp\": \"refs/heads/master@{#717774}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"d34bb293b205c32bcb9c2c918c18854ee09c1824\", \"got_v8_revision\": \"96bd79e5ddf97d6e48b1774ca953bf4084d1e93a\", \"got_v8_revision_cp\": \"refs/heads/8.0.329@{#1}\", \"got_webrtc_revision\": \"58a3210823a3faaad347b4e54606d493ec005fb1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29865}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4d4e06ddc3b2804340f343e0551076ae25f06941\", \"swarm_hashes_refs/heads/master(at){#717774}_without_patch\": {\"accessibility_unittests\": \"f3be9ec075cd754ed81adb6d4f0bd9fd49a92fc2\", \"angle_unittests\": \"a6f7a1fce595dbe1dae9ff2f06f4159b04d27a2d\", \"app_shell_unittests\": \"0ab5dfc77a207ce788e174489f6bb5def35bb424\", \"aura_unittests\": \"86420aca18c26aeb284ae54b34e649e9df002c0d\", \"base_unittests\": \"56a1f1266f87002d6db53dbd4bef87a760e94322\", \"base_util_unittests\": \"3ce148564ac849dd54323f47ffbaf73feb7198fa\", \"blink_common_unittests\": \"1cb144ff5d17d252b99af0a21baddd35676c05f0\", \"blink_fuzzer_unittests\": \"69941378272bdd262265aac598407c809b8ceaa5\", \"blink_heap_unittests\": \"58a9926b8dbdf0df62f674c3d750b9fb356914ad\", \"blink_platform_unittests\": \"7735bc340d8a18ed2865d043d7cae24b70021739\", \"blink_python_tests\": \"9597ec823bbf496ed63bee96c560120f048ec79f\", \"blink_unittests\": \"b98d5cec5a52185dddb253aae0b6fc998e0fbd92\", \"blink_web_tests_exparchive\": \"e7c08d193ad312e3b2bffb81de59c24ffb871323\", \"boringssl_crypto_tests\": \"8245e775fcfbda8aba6d201f9c7fc8a8d0947a37\", \"boringssl_ssl_tests\": \"8fe67dd6fd9beb4f4ad8cc8c85d0bc92126b2087\", \"browser_tests\": \"a1f9e6876592821fb14f62ec8c430972b29c2a30\", \"cacheinvalidation_unittests\": \"91b5c4f0290125e8820921f9f0501dbedce804fb\", \"capture_unittests\": \"eb3207e62a7590b0de56be4c287970521eabf261\", \"cast_unittests\": \"c9972044edbf7f459ae90d71c77d9d91716a3525\", \"cc_unittests\": \"500c2e3b4a1d89f8fd2786045e2f75c8e78cf555\", \"chrome_app_unittests\": \"25103cdcae75c9f9c31f38a7898afe75249a394d\", \"chromedriver_unittests\": \"52c3065377aba828fda2873a82682e2c69804594\", \"color_unittests\": \"23bf043771b461bc05462ccbbd4a34d8dae43d55\", \"components_browsertests\": \"fbebc655c7fe4acd664e6c5b2c1c1e77dbbda77b\", \"components_unittests\": \"a30783ef2e8afaf58684f3140b4f4eb2a1e27968\", \"compositor_unittests\": \"486201e2ca980af8b0f24caffe935f813dd4ee34\", \"content_browsertests\": \"38c686cb4199ab6b274005a7d341b55538ce098a\", \"content_shell_crash_test\": \"957019c9604c63d1aad466a4616070a4ae831c44\", \"content_unittests\": \"bd136563c1769662efc771bbff900e07777e24d0\", \"crashpad_tests\": \"42c8f6d38eb51731ccd39cc07080d64205c5e8b3\", \"cronet_tests\": \"2ce0c96b35a42bafec72f9926db3a8cc74a13012\", \"cronet_unittests\": \"5c5bfc28649fa10da032002ccbd31e50087ccbf6\", \"crypto_unittests\": \"aef26864bbe7b64f32c801d2ab72dc3e3aa5d6d9\", \"dbus_unittests\": \"15b9308c79f0abc4e67a2cfc3142b87aef63e37f\", \"device_unittests\": \"99dec6ad714af9f3a15da997312ebff097f94157\", \"devtools_lint_check\": \"cd702703f13611c997d560afdb86217d27a15fb5\", \"devtools_type_check\": \"5591eb775c4e5382154c74bb0b755154e4a48316\", \"display_unittests\": \"37b1d759ee9fe0b9973d0251deba3a9df5b4fbdb\", \"events_unittests\": \"6c048f587a6a0a3038f5f17dc26f5a35c95b6af7\", \"extensions_browsertests\": \"1f5a18a3338f4736ad438251d32265fb08376684\", \"extensions_unittests\": \"78b374f23ef6562b2dc9e625b7c64890b68d6866\", \"filesystem_service_unittests\": \"97bc61d8aff7502c2ea9d763c8b4fd968d15d82b\", \"flatbuffers_unittests\": \"68877d8b1262b0aa771438df1015a16a10098d5e\", \"gcm_unit_tests\": \"175c2aae0b471d648d963e8d721c1c7d1b5623fc\", \"gfx_unittests\": \"eda13b24e4f0ef65c9e414a2d965b1b6e7dec1a9\", \"gin_unittests\": \"1c431ed3ae0f469e4ec7ce51907cce3a2761f8c7\", \"google_apis_unittests\": \"3a9f849c96b0eac63611f70d217bf61b4e4d7c56\", \"gpu_unittests\": \"28d31479471c5bb84385082ce3cbc55666e6cfe8\", \"grit_python_unittests\": \"4267cdfe96cbb5881cc25cc5b15aab4b2f28c5f5\", \"gwp_asan_unittests\": \"3454441992a960dcd5e24e1f2724c61d8570b451\", \"headless_browsertests\": \"e494d6a11bd328f3dda3215979a7213154dbf0cd\", \"headless_unittests\": \"3a8b6f210c29f6aaf01a020938466ec4384cb1b0\", \"interactive_ui_tests\": \"745e9606ff2c300577dbbc326c1aad83eabff175\", \"ipc_tests\": \"8d643780673828abc1b73888aca0d194f5bb0e5f\", \"jingle_unittests\": \"cce87e87f8413544673479402c3e5fe9de61c326\", \"latency_unittests\": \"5ce5391d03a74892c325ff26d80dac32e21b6e4f\", \"libjingle_xmpp_unittests\": \"35be439a314b6892995d6df0e426c081ee5ac17c\", \"media_blink_unittests\": \"414c3208c7935e9f1bfe0e2268d959c7d1ce476e\", \"media_service_unittests\": \"2eb32531b1de3482a59074a285388914fec3bdbb\", \"media_unittests\": \"9481fee95772843fbbc5bb1cc9b268d8388578e5\", \"message_center_unittests\": \"b8526c5c430cf929a8de93611c9bf75bb787eb5d\", \"metrics_python_tests\": \"654607f582b0f7c83132f5128785665c0c32c2be\", \"midi_unittests\": \"f1971ac322827378e2cb694ee4146028a17d6c7e\", \"mojo_core_unittests\": \"c252dd8672d1784303f80d2438de5b309df738ad\", \"mojo_unittests\": \"447ef010b35e06850c34831b7373791d9c58cc56\", \"nacl_helper_nonsfi_unittests\": \"68fce67f17ade6d2683d93df1c44cd730b4336a4\", \"nacl_loader_unittests\": \"7548178b35ade3adb8617853b95605260295b67c\", \"native_theme_unittests\": \"720c5ff7582505aa5f66fb576623c8b5d80f5e5c\", \"net_unittests\": \"9f77c7a0bc457c435cf1d63fba1178e87f1a1af1\", \"pdf_unittests\": \"96e83910d5a0efbbdb2b14f5d3be090b53fb8f8d\", \"perfetto_unittests\": \"6e7b0d026db5940b048ec85d4f440419bf2a5604\", \"ppapi_unittests\": \"989f71acc2c8c1c4afe31ed54e756edd37c8059a\", \"printing_unittests\": \"d523bf70b8a9c8845f640699a9eb35b9c65622ce\", \"remoting_unittests\": \"c99d312a5fcef7852cddd1568cd6a20d8663c23b\", \"sandbox_linux_unittests\": \"413692bc8cb65a9313a9e55541eab41c22d5959b\", \"service_manager_unittests\": \"3339895b33b13971c4599dbe8b5c78d6d4f8b295\", \"services_unittests\": \"cb2e34377cd612445f087c2694cd24682f850c08\", \"shell_dialogs_unittests\": \"66a8d818f779768af08cb52f3159bc504ba6c8b6\", \"skia_unittests\": \"8d9f3f676b2f7444a5213b2f2d531b9402a8dedc\", \"snapshot_unittests\": \"02db7446a36acd03aaa26e11d11a397ebc361d8d\", \"sql_unittests\": \"8613392a3c228493b80b2ddc4a6d0d6a03cacca3\", \"storage_unittests\": \"890f5ebf9f9a9997a460a4b5cde6c48d39ae3a66\", \"sync_integration_tests\": \"f3016a9f26819e89a14d3d25430b23fc790d6de9\", \"telemetry_gpu_unittests\": \"1e62fd2a5915bf431f87f58c6b568dfe7a7bf40b\", \"telemetry_perf_unittests\": \"848a6a76c9425fcb44cd79241b8eaa5446a9bc70\", \"telemetry_unittests\": \"4c7d358de22fe3f696d117a051fddcaee85cd1e5\", \"traffic_annotation_auditor_unittests\": \"6a31616653da03330dbe4a81ca6c3e7c1357a434\", \"ui_base_unittests\": \"bf7bd4b5bc7edc07bf68792d64ffdb68b217cb78\", \"ui_touch_selection_unittests\": \"df03cf48abbed3483b6ed8aab17cb3c149b26f26\", \"unit_tests\": \"db48c5dc13a803983a77880d336e5c678966d967\", \"url_unittests\": \"4f5088cbd6fb381db233162b9014f53213cced1a\", \"views_perftests\": \"27e6bfe6ee541498356c1b86d74c9ab80eb92630\", \"views_unittests\": \"bb4d05d196541f7f4141f1e8dcee6a7879537928\", \"viz_unittests\": \"7b045e3905e0bffd525e6c2928cba1d6d4b83996\", \"vr_common_unittests\": \"36f89c1d6c10901699fec49b799495512589efcc\", \"vr_pixeltests\": \"bfd9bca5e0b33efacf82b2bcdb29da004fde197b\", \"webdriver_wpt_tests\": \"bb1f00f488e5a3de469738039105fc405a10a338\", \"weblayer_browsertests\": \"e693753dcb59a0721d78857331884f90e112d327\", \"wm_unittests\": \"493b7401fc8041a38f450c2d39b95673da8c5bbe\", \"wtf_unittests\": \"5ed5f337484d3ee3e3ec81e103203c3343236027\", \"xr_browser_tests\": \"a88eb5f3171e825849ecb9696773a4964568258a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0b04f8cc6159258d804e25106396716d7d6fee48172e72693cbc82316c10e569_v2\", \"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_v2\", \"builder_d0ba3cd99c36b697d8651140d51bf4b4f4b9cd9aa25af11363af5ede5f6e35b1_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-7-a26u\"], \"image\": [\"chrome-xenial-19111101-9a63619e779\"], \"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\": [\"4645-7f6a85d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1574367880577442",
"status": "COMPLETED",
"status_changed_ts": "1574370575363440",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165121",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4d4e06ddc3b2804340f343e0551076ae25f06941",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d4e06ddc3b2804340f343e0551076ae25f06941",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061579483871007328",
"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/8896149418360190528/+/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:48a8742d73a95810",
"user_agent:luci-scheduler"
],
"updated_ts": "1574370575369032",
"url": "https://ci.chromium.org/b/8896149418360190528",
"utcnow_ts": "1574370576716605"
}
}
[21:09:36.737] Invocation finished in 46m14.370922295s with status SUCCEEDED