[19:25:22.597] New invocation is queued and will start shortly
[19:25:24.153] Starting the invocation (attempt 1)
[19:25:24.224] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:25:24.224] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:25:24.224] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059771193365597488",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"011ca093a79692f717e7d6a454c1d97abced38eb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9059771193365597488",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/011ca093a79692f717e7d6a454c1d97abced38eb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/011ca093a79692f717e7d6a454c1d97abced38eb",
"gitiles_ref:refs/heads/master"
]
}
[19:25:26.659] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1576092324970476",
"id": "8894341130210305424",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"011ca093a79692f717e7d6a454c1d97abced38eb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576092326077022",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165962",
"builder:Linux Builder (dbg)",
"buildset:commit/git/011ca093a79692f717e7d6a454c1d97abced38eb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/011ca093a79692f717e7d6a454c1d97abced38eb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059771193365597488",
"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/8894341130210305424/+/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": "1576092326077169",
"url": "https://ci.chromium.org/b/8894341130210305424",
"utcnow_ts": "1576092326647790"
}
}
[19:25:26.659] Task URL: https://ci.chromium.org/b/8894341130210305424
[19:25:26.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:2:0) after 1m0s
[19:26:26.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:2:0)
[19:26:26.939] Timer tick, asking Buildbucket for the build status
[19:26:27.250] Build 8894341130210305424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:26:27.250] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:3:0) after 1m0s
[19:27:27.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:3:0)
[19:27:27.422] Timer tick, asking Buildbucket for the build status
[19:27:27.629] Build 8894341130210305424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:27:27.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:4:0) after 1m0s
[19:28:27.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:4:0)
[19:28:27.714] Timer tick, asking Buildbucket for the build status
[19:28:28.973] Build 8894341130210305424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:28:28.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:5:0) after 1m0s
[19:29:29.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:5:0)
[19:29:29.474] Timer tick, asking Buildbucket for the build status
[19:29:30.051] Build 8894341130210305424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:29:30.051] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:6:0) after 1m0s
[19:30:03.375] Received PubSub notification, asking Buildbucket for the build status
[19:30:05.228] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:30.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:6:0)
[19:30:30.212] Timer tick, asking Buildbucket for the build status
[19:30:30.596] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:30.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:8:0) after 1m0s
[19:31:30.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:8:0)
[19:31:30.675] Timer tick, asking Buildbucket for the build status
[19:31:31.424] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:31.424] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:9:0) after 1m0s
[19:32:31.470] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:9:0)
[19:32:31.470] Timer tick, asking Buildbucket for the build status
[19:32:31.658] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:31.658] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:10:0) after 1m0s
[19:33:31.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:10:0)
[19:33:31.702] Timer tick, asking Buildbucket for the build status
[19:33:31.851] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:31.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:11:0) after 1m0s
[19:34:32.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:11:0)
[19:34:32.043] Timer tick, asking Buildbucket for the build status
[19:34:32.867] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:32.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:12:0) after 1m0s
[19:35:33.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:12:0)
[19:35:33.117] Timer tick, asking Buildbucket for the build status
[19:35:33.332] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:33.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:13:0) after 1m0s
[19:36:33.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:13:0)
[19:36:33.558] Timer tick, asking Buildbucket for the build status
[19:36:33.757] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:33.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:14:0) after 1m0s
[19:37:34.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:14:0)
[19:37:34.528] Timer tick, asking Buildbucket for the build status
[19:37:34.674] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:34.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:15:0) after 1m0s
[19:38:35.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:15:0)
[19:38:35.092] Timer tick, asking Buildbucket for the build status
[19:38:37.705] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:37.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:16:0) after 1m0s
[19:39:37.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:16:0)
[19:39:37.839] Timer tick, asking Buildbucket for the build status
[19:39:38.059] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:38.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:17:0) after 1m0s
[19:40:38.336] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:17:0)
[19:40:38.336] Timer tick, asking Buildbucket for the build status
[19:40:41.023] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:41.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:18:0) after 1m0s
[19:41:41.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:18:0)
[19:41:41.125] Timer tick, asking Buildbucket for the build status
[19:41:41.298] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:41.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:19:0) after 1m0s
[19:42:41.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:19:0)
[19:42:41.373] Timer tick, asking Buildbucket for the build status
[19:42:41.581] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:41.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:20:0) after 1m0s
[19:43:41.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:20:0)
[19:43:41.691] Timer tick, asking Buildbucket for the build status
[19:43:42.255] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:42.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:21:0) after 1m0s
[19:44:42.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:21:0)
[19:44:42.405] Timer tick, asking Buildbucket for the build status
[19:44:42.897] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:42.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:22:0) after 1m0s
[19:45:43.104] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:22:0)
[19:45:43.104] Timer tick, asking Buildbucket for the build status
[19:45:43.960] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:43.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:23:0) after 1m0s
[19:46:43.987] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:23:0)
[19:46:43.987] Timer tick, asking Buildbucket for the build status
[19:46:46.805] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:46.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:24:0) after 1m0s
[19:47:46.880] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:24:0)
[19:47:46.881] Timer tick, asking Buildbucket for the build status
[19:47:51.513] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:51.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:25:0) after 1m0s
[19:48:51.980] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:25:0)
[19:48:51.980] Timer tick, asking Buildbucket for the build status
[19:48:52.149] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:52.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:26:0) after 1m0s
[19:49:52.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:26:0)
[19:49:52.716] Timer tick, asking Buildbucket for the build status
[19:49:54.362] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:54.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:27:0) after 1m0s
[19:50:54.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:27:0)
[19:50:54.464] Timer tick, asking Buildbucket for the build status
[19:50:55.107] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:55.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:28:0) after 1m0s
[19:51:55.198] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:28:0)
[19:51:55.198] Timer tick, asking Buildbucket for the build status
[19:51:55.457] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:55.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:29:0) after 1m0s
[19:52:55.533] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:29:0)
[19:52:55.534] Timer tick, asking Buildbucket for the build status
[19:52:55.711] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:55.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:30:0) after 1m0s
[19:53:55.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:30:0)
[19:53:55.848] Timer tick, asking Buildbucket for the build status
[19:53:56.384] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:56.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:31:0) after 1m0s
[19:54:56.572] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:31:0)
[19:54:56.572] Timer tick, asking Buildbucket for the build status
[19:54:57.163] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:57.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:32:0) after 1m0s
[19:55:57.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:32:0)
[19:55:57.228] Timer tick, asking Buildbucket for the build status
[19:55:57.494] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:57.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:33:0) after 1m0s
[19:56:57.581] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:33:0)
[19:56:57.581] Timer tick, asking Buildbucket for the build status
[19:56:57.934] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:57.934] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:34:0) after 1m0s
[19:57:58.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:34:0)
[19:57:58.052] Timer tick, asking Buildbucket for the build status
[19:57:58.752] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:58.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:35:0) after 1m0s
[19:58:58.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:35:0)
[19:58:58.836] Timer tick, asking Buildbucket for the build status
[19:58:59.065] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:59.065] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:36:0) after 1m0s
[19:59:59.180] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:36:0)
[19:59:59.180] Timer tick, asking Buildbucket for the build status
[19:59:59.497] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:59.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:37:0) after 1m0s
[20:00:59.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:37:0)
[20:00:59.756] Timer tick, asking Buildbucket for the build status
[20:01:00.215] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:00.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:38:0) after 1m0s
[20:02:00.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:38:0)
[20:02:00.371] Timer tick, asking Buildbucket for the build status
[20:02:00.879] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:00.879] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:39:0) after 1m0s
[20:03:01.120] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:39:0)
[20:03:01.120] Timer tick, asking Buildbucket for the build status
[20:03:01.487] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:01.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:40:0) after 1m0s
[20:04:01.499] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:40:0)
[20:04:01.499] Timer tick, asking Buildbucket for the build status
[20:04:01.653] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:01.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:41:0) after 1m0s
[20:05:01.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:41:0)
[20:05:01.708] Timer tick, asking Buildbucket for the build status
[20:05:02.477] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:02.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:42:0) after 1m0s
[20:06:02.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:42:0)
[20:06:02.541] Timer tick, asking Buildbucket for the build status
[20:06:03.043] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:03.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:43:0) after 1m0s
[20:07:03.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:43:0)
[20:07:03.142] Timer tick, asking Buildbucket for the build status
[20:07:03.333] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:03.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:44:0) after 1m0s
[20:08:03.475] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:44:0)
[20:08:03.475] Timer tick, asking Buildbucket for the build status
[20:08:03.778] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:03.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:45:0) after 1m0s
[20:09:03.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:45:0)
[20:09:03.954] Timer tick, asking Buildbucket for the build status
[20:09:04.230] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:04.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:46:0) after 1m0s
[20:10:04.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:46:0)
[20:10:04.401] Timer tick, asking Buildbucket for the build status
[20:10:04.856] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:04.856] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:47:0) after 1m0s
[20:11:05.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:47:0)
[20:11:05.035] Timer tick, asking Buildbucket for the build status
[20:11:05.384] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:05.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:48:0) after 1m0s
[20:12:05.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:48:0)
[20:12:05.511] Timer tick, asking Buildbucket for the build status
[20:12:06.829] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:06.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:49:0) after 1m0s
[20:13:06.947] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:49:0)
[20:13:06.947] Timer tick, asking Buildbucket for the build status
[20:13:07.450] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:07.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:50:0) after 1m0s
[20:14:07.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:50:0)
[20:14:07.825] Timer tick, asking Buildbucket for the build status
[20:14:09.724] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:09.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:51:0) after 1m0s
[20:15:10.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:51:0)
[20:15:10.038] Timer tick, asking Buildbucket for the build status
[20:15:10.349] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:10.349] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:52:0) after 1m0s
[20:16:10.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:52:0)
[20:16:10.507] Timer tick, asking Buildbucket for the build status
[20:16:11.559] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:11.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:53:0) after 1m0s
[20:17:11.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:53:0)
[20:17:11.626] Timer tick, asking Buildbucket for the build status
[20:17:11.813] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:11.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:54:0) after 1m0s
[20:18:11.883] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:54:0)
[20:18:11.883] Timer tick, asking Buildbucket for the build status
[20:18:13.007] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:13.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:55:0) after 1m0s
[20:19:13.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:55:0)
[20:19:13.158] Timer tick, asking Buildbucket for the build status
[20:19:13.578] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:13.578] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:56:0) after 1m0s
[20:20:13.816] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:56:0)
[20:20:13.816] Timer tick, asking Buildbucket for the build status
[20:20:14.325] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:14.325] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:57:0) after 1m0s
[20:21:14.479] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:57:0)
[20:21:14.479] Timer tick, asking Buildbucket for the build status
[20:21:15.214] Build 8894341130210305424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:15.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059771193365597488:58:0) after 1m0s
[20:21:24.319] Received PubSub notification, asking Buildbucket for the build status
[20:21:24.501] Build 8894341130210305424: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:21:24.501] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1576095683195244",
"created_by": "project:chromium",
"created_ts": "1576092324970476",
"id": "8894341130210305424",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"011ca093a79692f717e7d6a454c1d97abced38eb\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-35-3w5c\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 165962, \"got_angle_revision\": \"4ad8b55ef4274c730788fe3d42e6ebc27095ca6e\", \"got_dawn_revision\": \"280b96ea8de35e145be4878ca53b6eecf7f38e67\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"011ca093a79692f717e7d6a454c1d97abced38eb\", \"got_revision_cp\": \"refs/heads/master@{#723921}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"11dcf980f50784e40003a00796470406c9e7f9fb\", \"got_v8_revision\": \"99201c7be24457c993b6fe23280830d2cec6153c\", \"got_v8_revision_cp\": \"refs/heads/8.1.16@{#1}\", \"got_webrtc_revision\": \"75bc75ccef59caeeeecdeac83426565efddb6780\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30064}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"011ca093a79692f717e7d6a454c1d97abced38eb\", \"swarm_hashes_refs/heads/master(at){#723921}_without_patch\": {\"accessibility_unittests\": \"c8822151942f7291a2cf682ed45c809844e3af38\", \"angle_unittests\": \"103a3e1b476831771b206707944d980e67841dfc\", \"app_shell_unittests\": \"3af5f9bc12cb0ed202987ae09451cb36ed5d8681\", \"aura_unittests\": \"db620720a1c8938b72986826c284ffd36c9239ec\", \"base_unittests\": \"0d3a0abc8f42acb3b5d6b8a39459e67c4999bb77\", \"base_util_unittests\": \"485c91b0a97c1d80af2d66165bb2223657b077f3\", \"blink_common_unittests\": \"ba880e13b33249a6bfa50443aaeb8a4087e3ba9d\", \"blink_fuzzer_unittests\": \"ec90a0588475c23572f20060fc65bff611f8d13c\", \"blink_heap_unittests\": \"d02f7c28f57e9ffa2495a0bd698a7e66bacd1659\", \"blink_platform_unittests\": \"89c87d0e579b03074b50d06437a143e3b2f3ed27\", \"blink_python_tests\": \"3e933c9370d16046ae14d2e93f86568993c82d58\", \"blink_unittests\": \"0226a81c3ea66403a8862440c24a4a5d5d890679\", \"blink_web_tests\": \"6abcc54fd30ec3633cb34892b96c968bd2c3fcfb\", \"boringssl_crypto_tests\": \"11f1a077fa0155406b0c8d3bef04b839391a6e2d\", \"boringssl_ssl_tests\": \"3da0a7fbee1468544df83d41017ded0ac30bc959\", \"browser_tests\": \"13cd62daf04f79a1a46f56636b99392b30a95f4e\", \"cacheinvalidation_unittests\": \"c6155d973b1ded198a26e03827ebb7c8c38128d9\", \"capture_unittests\": \"b78f1d5955c964e85a61c05b11c6b03af518cf27\", \"cast_unittests\": \"2e19d9de1b1c21312442795afda5c06ef9987ade\", \"cc_unittests\": \"48613f61f315216904496111de7986d6c0c00300\", \"chrome_app_unittests\": \"e01b9ed1def75d232c0504457388d976afa70e20\", \"chromedriver_unittests\": \"c9fcf5dbda72d3672d9d4fc822fed85fe9e7dac5\", \"components_browsertests\": \"fa38907bf0ef8c36b6cbfd1c564f01f9e94edd32\", \"components_unittests\": \"5585884de22e147f68b157a238967f384d7b7dc2\", \"compositor_unittests\": \"efe83b5b0dc9b09655283034ac380177c48cace8\", \"content_browsertests\": \"773d94910b617043713eb40a6c10b6c89e46f512\", \"content_shell_crash_test\": \"8c97d89ca954b347c57b40e3de0e3d23029ba9c7\", \"content_unittests\": \"ad69621e6eaa0ebc6533cbb4e19d6233d33c6eb6\", \"crashpad_tests\": \"a0bd57225e265c9c255f49c6a9577d071b8397ed\", \"cronet_tests\": \"e48cc0f881a8fb75e16d9564a7225d492e5f4421\", \"cronet_unittests\": \"d80627c59539bc9acb8cb4d890775072e3265252\", \"crypto_unittests\": \"d80790968ca92932e10de78677ade7089acad773\", \"dbus_unittests\": \"6a2855af41cd183e5d170fcd65e88bae8a26dede\", \"device_unittests\": \"750b37fd8a52b83ad7ddc5dbae25a3ca75131f29\", \"devtools_lint_check\": \"a3903627a234473fdff3ef6478bb0d5d3a1f00ac\", \"devtools_type_check\": \"25da940eb98262c28e9af322fcc14739b974a231\", \"display_unittests\": \"9fe442aa3fee78e311b9e714324a819dbfa96c86\", \"events_unittests\": \"0dcc5d62b0e44eace1d6be452ddddafdbb619860\", \"extensions_browsertests\": \"3dbd07413628089730cca5af5dfee4dfa4faf2cd\", \"extensions_unittests\": \"522732a9ff0a4acff7c75298f8177c90f08dae44\", \"filesystem_service_unittests\": \"08abc8f3a5ab91412d49d490d51b53d4bee71c4d\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"c23d1ed3c62d96d452022865b80ca26da14b22f4\", \"gfx_unittests\": \"53eaaf07f7e00185ee1827669eedc66e9ad1ead8\", \"gin_unittests\": \"491cf352527b21f6037706e61c56b5851a5c4609\", \"google_apis_unittests\": \"41d01d8bb7d233e0a1bb30e11e87d4d653a7ee14\", \"gpu_unittests\": \"0194291052de35a047d38fd47929bc82d281a7a1\", \"grit_python_unittests\": \"c949091fb2717b913781a9a7cb15efe1537c4608\", \"gwp_asan_unittests\": \"b2939cd5fd508c3da068939b0cdf718613826a50\", \"headless_browsertests\": \"f19df192653693071fe6e62e311e4d88b8f13bd6\", \"headless_unittests\": \"7b52d0e38c13a07b41c7405c10bb58ae0a74939a\", \"interactive_ui_tests\": \"eb536fd7b768722f8c3494adc6c9635dd46ea10e\", \"ipc_tests\": \"7dfbc62764178e3a7846ee7a0de24d3b06b3a4e1\", \"jingle_unittests\": \"a043b86f2d4ae271770cc9f4aed12862befd59dd\", \"latency_unittests\": \"fc66bd478953f0af83cdd4a964dfde81b092a59e\", \"libjingle_xmpp_unittests\": \"cebca00478ed0f9882e756ad808808652709b525\", \"media_blink_unittests\": \"9b7af85b626df4f8d8eec55c03c8c144c89e83da\", \"media_service_unittests\": \"38485b1a0b8a64fdf92bb0cc24ba3ccd13e21ab7\", \"media_unittests\": \"7882488cd8d9faaebb9a45af15e0c91423763461\", \"message_center_unittests\": \"7c09e4fbe0ddbde1fec74273ddfc3782da18c4e2\", \"metrics_python_tests\": \"a378e7ab3739df6f446af01f1160d80ae8fc8752\", \"midi_unittests\": \"656d8b45a0c954ffecc112a792f1078692cfa50b\", \"mojo_core_unittests\": \"7b73240ca727f3e980fb9795ce869c16fac4099d\", \"mojo_unittests\": \"227a61ab21a060d4e88614d3ed8f0c8617c427fd\", \"nacl_helper_nonsfi_unittests\": \"c2d453b20530d77066a37ad40698718617fb458f\", \"nacl_loader_unittests\": \"5be7f10502faee638b58306a865c51f625e121dc\", \"native_theme_unittests\": \"ae4ab5b5b49c3fe03f2b26dde51d40de068464ea\", \"net_unittests\": \"1077ba8c8d54e44a61d335563edd6c1265b5ab30\", \"pdf_unittests\": \"c0a27cd983f5616efb0124c3beb9adcc248ec891\", \"perfetto_unittests\": \"d3b30eed1cf83dd231700bc81dcc40ec13d27365\", \"ppapi_unittests\": \"aedfdc23d124257a39fb07c6fcb16fd0cfef17c3\", \"printing_unittests\": \"0a08d56538c3e14d64dc018e3d55bb4b66d2c9cd\", \"remoting_unittests\": \"afde0f0e1693c1d7026f7bc944e20b7da2e1dcba\", \"sandbox_linux_unittests\": \"0caa77dd588ea291810a44b1ca72eb99fc894e81\", \"service_manager_unittests\": \"ef394609ceb3466825806455dc430a373d115ac0\", \"services_unittests\": \"007956f71657ecd8b1d7844b40fee01e655e78c8\", \"shell_dialogs_unittests\": \"bdae92acd174a3289937fa20344c7cfa9962ddc5\", \"skia_unittests\": \"ec8770815203dd3fb31424d0d7bd98998ec56dbf\", \"snapshot_unittests\": \"992c91b3c9fd75a57b1261f91290a36c9e9defb8\", \"sql_unittests\": \"d52ef03a4d997eb7f9bbf468b9c2325083842dfc\", \"storage_unittests\": \"2de1f5aa6cd0ae63035e02179a0e420659587adc\", \"sync_integration_tests\": \"116d8dbf92919f916f455a320c08363e6bc8c7e6\", \"telemetry_gpu_unittests\": \"8f7e68daa8cb310f221a1594901517b1a2b0ef0f\", \"telemetry_perf_unittests\": \"7e6b44845dec90c372615458e137c9c2c9bef0f4\", \"telemetry_unittests\": \"4d767926cfafdd5ea6353355f0f6b3498d723a99\", \"traffic_annotation_auditor_unittests\": \"05a01598bb0bbb318620379c6a7961706f716ad3\", \"ui_base_unittests\": \"3d958e4fbde668fbf916bda1e27c8480f5aa0868\", \"ui_touch_selection_unittests\": \"24cfbd0270af787059b67968b4134d0f368e9d9c\", \"unit_tests\": \"c02c128fc88662e2f59cfb36f1508aa445b2fba3\", \"url_unittests\": \"a94d03792bc2852ff36cb1ac1f884dfa1540f907\", \"views_perftests\": \"4a400ca75b6b08e6c5fdf21c53ce05cb25157f53\", \"views_unittests\": \"d8db072c8a23a2eba899b4f2a2312420220a64d4\", \"viz_unittests\": \"443ed5e785e47c7ca384d29fea3b6555c8714a63\", \"vr_common_unittests\": \"a63daf0aa2a24886add22029c2cccba77955b381\", \"vr_pixeltests\": \"0de283dfac0bec832ad34f178970508e664daa76\", \"webdriver_wpt_tests\": \"86aa0bd2b8ac6e63ebb72ae0b9998402b5f532c9\", \"weblayer_browsertests\": \"69d4aaf48c4cfa6efc9e5031289d6f7cb1bc2fc4\", \"wm_unittests\": \"de03efa22e3379184a20cc63296dfa4fa23b7513\", \"wtf_unittests\": \"43019f5a04b08fe499e79b7a3810716593d054ba\", \"xr_browser_tests\": \"6e49607b49d392c08259c82f872cdbfb0d1101a4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_387e931c7b633ee2f48b892df14288ffa2061feda74b30444810d565fa474120_v2\", \"builder_c9091f6bc58db7983401393b6dacc93b3db8fae2c2ae9b40177b9e0904c8bc80_v2\", \"builder_f1e9b75398bfd0252c605ce36f207e46561896ce8d2d0d3f277d5138614391a3_v2\", \"builder_fc85390932f60be0e3ac2fe3fabccf73080e82ff5de9472ae253be8b859a725c_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-east1-d-8-35-3w5c\"], \"image\": [\"chrome-xenial-19120100-f3a09baa543\"], \"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\": [\"4709-f2c88b6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1576092602284320",
"status": "COMPLETED",
"status_changed_ts": "1576095683821775",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165962",
"builder:Linux Builder (dbg)",
"buildset:commit/git/011ca093a79692f717e7d6a454c1d97abced38eb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/011ca093a79692f717e7d6a454c1d97abced38eb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059771193365597488",
"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/8894341130210305424/+/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:490f3e2d78f94410",
"user_agent:luci-scheduler"
],
"updated_ts": "1576095683859339",
"url": "https://ci.chromium.org/b/8894341130210305424",
"utcnow_ts": "1576095684491172"
}
}
[20:21:24.501] Invocation finished in 56m1.923316483s with status SUCCEEDED