[20:07:20.505] New invocation is queued and will start shortly
[20:07:21.639] Starting the invocation (attempt 1)
[20:07:21.703] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:07:21.703] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:07:21.703] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059315568325560768",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f0221d2cf3f451d3731d4ff9214dabd4fdc00f79\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9059315568325560768",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/f0221d2cf3f451d3731d4ff9214dabd4fdc00f79",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f0221d2cf3f451d3731d4ff9214dabd4fdc00f79",
"gitiles_ref:refs/heads/master"
]
}
[20:07:23.379] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1576526842795230",
"id": "8893885505248060704",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f0221d2cf3f451d3731d4ff9214dabd4fdc00f79\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576526843200354",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166175",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f0221d2cf3f451d3731d4ff9214dabd4fdc00f79",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f0221d2cf3f451d3731d4ff9214dabd4fdc00f79",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059315568325560768",
"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/8893885505248060704/+/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": "1576526843200479",
"url": "https://ci.chromium.org/b/8893885505248060704",
"utcnow_ts": "1576526843370224"
}
}
[20:07:23.379] Task URL: https://ci.chromium.org/b/8893885505248060704
[20:07:23.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:2:0) after 1m0s
[20:08:23.402] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:2:0)
[20:08:23.402] Timer tick, asking Buildbucket for the build status
[20:08:23.616] Build 8893885505248060704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:23.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:3:0) after 1m0s
[20:09:23.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:3:0)
[20:09:23.744] Timer tick, asking Buildbucket for the build status
[20:09:23.978] Build 8893885505248060704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:23.978] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:4:0) after 1m0s
[20:10:24.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:4:0)
[20:10:24.473] Timer tick, asking Buildbucket for the build status
[20:10:25.171] Build 8893885505248060704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:25.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:5:0) after 1m0s
[20:11:25.277] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:5:0)
[20:11:25.277] Timer tick, asking Buildbucket for the build status
[20:11:28.142] Build 8893885505248060704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:28.142] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:6:0) after 1m0s
[20:12:03.958] Received PubSub notification, asking Buildbucket for the build status
[20:12:04.105] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:28.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:6:0)
[20:12:28.548] Timer tick, asking Buildbucket for the build status
[20:12:28.741] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:28.741] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:8:0) after 1m0s
[20:13:28.874] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:8:0)
[20:13:28.874] Timer tick, asking Buildbucket for the build status
[20:13:29.461] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:29.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:9:0) after 1m0s
[20:14:29.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:9:0)
[20:14:29.629] Timer tick, asking Buildbucket for the build status
[20:14:30.518] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:30.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:10:0) after 1m0s
[20:15:30.911] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:10:0)
[20:15:30.911] Timer tick, asking Buildbucket for the build status
[20:15:32.188] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:32.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:11:0) after 1m0s
[20:16:32.256] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:11:0)
[20:16:32.256] Timer tick, asking Buildbucket for the build status
[20:16:32.672] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:32.672] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:12:0) after 1m0s
[20:17:32.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:12:0)
[20:17:32.795] Timer tick, asking Buildbucket for the build status
[20:17:33.260] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:33.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:13:0) after 1m0s
[20:18:33.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:13:0)
[20:18:33.608] Timer tick, asking Buildbucket for the build status
[20:18:33.927] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:33.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:14:0) after 1m0s
[20:19:34.495] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:14:0)
[20:19:34.495] Timer tick, asking Buildbucket for the build status
[20:19:35.835] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:35.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:15:0) after 1m0s
[20:20:36.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:15:0)
[20:20:36.212] Timer tick, asking Buildbucket for the build status
[20:20:36.411] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:36.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:16:0) after 1m0s
[20:21:36.456] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:16:0)
[20:21:36.456] Timer tick, asking Buildbucket for the build status
[20:21:36.998] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:36.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:17:0) after 1m0s
[20:22:37.115] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:17:0)
[20:22:37.115] Timer tick, asking Buildbucket for the build status
[20:22:37.307] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:37.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:18:0) after 1m0s
[20:23:37.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:18:0)
[20:23:37.300] Timer tick, asking Buildbucket for the build status
[20:23:37.568] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:37.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:19:0) after 1m0s
[20:24:38.004] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:19:0)
[20:24:38.004] Timer tick, asking Buildbucket for the build status
[20:24:38.190] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:38.190] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:20:0) after 1m0s
[20:25:38.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:20:0)
[20:25:38.324] Timer tick, asking Buildbucket for the build status
[20:25:39.946] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:39.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:21:0) after 1m0s
[20:26:40.079] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:21:0)
[20:26:40.080] Timer tick, asking Buildbucket for the build status
[20:26:42.764] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:42.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:22:0) after 1m0s
[20:27:42.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:22:0)
[20:27:42.800] Timer tick, asking Buildbucket for the build status
[20:27:43.188] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:43.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:23:0) after 1m0s
[20:28:43.223] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:23:0)
[20:28:43.223] Timer tick, asking Buildbucket for the build status
[20:28:43.525] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:43.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:24:0) after 1m0s
[20:29:43.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:24:0)
[20:29:43.559] Timer tick, asking Buildbucket for the build status
[20:29:43.660] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:43.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:25:0) after 1m0s
[20:30:43.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:25:0)
[20:30:43.843] Timer tick, asking Buildbucket for the build status
[20:30:44.376] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:44.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:26:0) after 1m0s
[20:31:44.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:26:0)
[20:31:44.424] Timer tick, asking Buildbucket for the build status
[20:31:44.720] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:44.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:27:0) after 1m0s
[20:32:44.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:27:0)
[20:32:44.786] Timer tick, asking Buildbucket for the build status
[20:32:46.722] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:46.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:28:0) after 1m0s
[20:33:46.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:28:0)
[20:33:46.824] Timer tick, asking Buildbucket for the build status
[20:33:47.690] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:47.690] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:29:0) after 1m0s
[20:34:48.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:29:0)
[20:34:48.039] Timer tick, asking Buildbucket for the build status
[20:34:48.408] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:48.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:30:0) after 1m0s
[20:35:48.430] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:30:0)
[20:35:48.430] Timer tick, asking Buildbucket for the build status
[20:35:48.614] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:48.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:31:0) after 1m0s
[20:36:48.689] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:31:0)
[20:36:48.689] Timer tick, asking Buildbucket for the build status
[20:36:49.731] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:49.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:32:0) after 1m0s
[20:37:49.808] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:32:0)
[20:37:49.808] Timer tick, asking Buildbucket for the build status
[20:37:50.013] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:50.013] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:33:0) after 1m0s
[20:38:50.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:33:0)
[20:38:50.035] Timer tick, asking Buildbucket for the build status
[20:38:51.441] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:51.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:34:0) after 1m0s
[20:39:51.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:34:0)
[20:39:51.561] Timer tick, asking Buildbucket for the build status
[20:39:51.750] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:51.750] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:35:0) after 1m0s
[20:40:51.802] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:35:0)
[20:40:51.802] Timer tick, asking Buildbucket for the build status
[20:40:52.018] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:52.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:36:0) after 1m0s
[20:41:52.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:36:0)
[20:41:52.189] Timer tick, asking Buildbucket for the build status
[20:41:53.000] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:53.000] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:37:0) after 1m0s
[20:42:53.024] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:37:0)
[20:42:53.024] Timer tick, asking Buildbucket for the build status
[20:42:53.390] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:53.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:38:0) after 1m0s
[20:43:53.426] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:38:0)
[20:43:53.426] Timer tick, asking Buildbucket for the build status
[20:43:53.854] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:53.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:39:0) after 1m0s
[20:44:54.096] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:39:0)
[20:44:54.096] Timer tick, asking Buildbucket for the build status
[20:44:54.418] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:54.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:40:0) after 1m0s
[20:45:54.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:40:0)
[20:45:54.550] Timer tick, asking Buildbucket for the build status
[20:45:54.916] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:54.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:41:0) after 1m0s
[20:46:55.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:41:0)
[20:46:55.099] Timer tick, asking Buildbucket for the build status
[20:46:55.366] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:55.366] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:42:0) after 1m0s
[20:47:55.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:42:0)
[20:47:55.483] Timer tick, asking Buildbucket for the build status
[20:47:55.932] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:55.932] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:43:0) after 1m0s
[20:48:56.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:43:0)
[20:48:56.071] Timer tick, asking Buildbucket for the build status
[20:48:56.294] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:56.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:44:0) after 1m0s
[20:49:56.319] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:44:0)
[20:49:56.319] Timer tick, asking Buildbucket for the build status
[20:49:57.006] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:57.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:45:0) after 1m0s
[20:50:57.009] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:45:0)
[20:50:57.009] Timer tick, asking Buildbucket for the build status
[20:50:57.223] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:57.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:46:0) after 1m0s
[20:51:57.311] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:46:0)
[20:51:57.311] Timer tick, asking Buildbucket for the build status
[20:51:57.558] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:57.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:47:0) after 1m0s
[20:52:57.580] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:47:0)
[20:52:57.580] Timer tick, asking Buildbucket for the build status
[20:52:57.753] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:57.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:48:0) after 1m0s
[20:53:57.777] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:48:0)
[20:53:57.777] Timer tick, asking Buildbucket for the build status
[20:53:57.995] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:57.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:49:0) after 1m0s
[20:54:58.042] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:49:0)
[20:54:58.042] Timer tick, asking Buildbucket for the build status
[20:54:58.512] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:58.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:50:0) after 1m0s
[20:55:58.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:50:0)
[20:55:58.535] Timer tick, asking Buildbucket for the build status
[20:55:59.111] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:59.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:51:0) after 1m0s
[20:56:59.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:51:0)
[20:56:59.209] Timer tick, asking Buildbucket for the build status
[20:56:59.488] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:59.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:52:0) after 1m0s
[20:57:59.509] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:52:0)
[20:57:59.509] Timer tick, asking Buildbucket for the build status
[20:57:59.762] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:59.762] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:53:0) after 1m0s
[20:58:59.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:53:0)
[20:58:59.800] Timer tick, asking Buildbucket for the build status
[20:59:00.493] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:00.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:54:0) after 1m0s
[21:00:00.485] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:54:0)
[21:00:00.485] Timer tick, asking Buildbucket for the build status
[21:00:00.695] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:00.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:55:0) after 1m0s
[21:01:00.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:55:0)
[21:01:00.785] Timer tick, asking Buildbucket for the build status
[21:01:01.431] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:01.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:56:0) after 1m0s
[21:02:01.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:56:0)
[21:02:01.474] Timer tick, asking Buildbucket for the build status
[21:02:02.047] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:02.047] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:57:0) after 1m0s
[21:03:02.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:57:0)
[21:03:02.077] Timer tick, asking Buildbucket for the build status
[21:03:03.701] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:03.702] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:58:0) after 1m0s
[21:04:03.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:58:0)
[21:04:03.724] Timer tick, asking Buildbucket for the build status
[21:04:04.814] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:04.814] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:59:0) after 1m0s
[21:05:04.881] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:59:0)
[21:05:04.881] Timer tick, asking Buildbucket for the build status
[21:05:05.479] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:05.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:60:0) after 1m0s
[21:06:05.606] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:60:0)
[21:06:05.606] Timer tick, asking Buildbucket for the build status
[21:06:05.980] Build 8893885505248060704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:05.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059315568325560768:61:0) after 1m0s
[21:06:53.633] Received PubSub notification, asking Buildbucket for the build status
[21:06:53.970] Build 8893885505248060704: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:06:53.970] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1576530412607349",
"created_by": "project:chromium",
"created_ts": "1576526842795230",
"id": "8893885505248060704",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f0221d2cf3f451d3731d4ff9214dabd4fdc00f79\"}}",
"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-86-d5pv\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 166175, \"got_angle_revision\": \"7587588595901010a7b8d8683d06796ae420edb8\", \"got_dawn_revision\": \"77fd4750ae5ad3ee9f281089fddfeaca56ed049c\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"f0221d2cf3f451d3731d4ff9214dabd4fdc00f79\", \"got_revision_cp\": \"refs/heads/master@{#725232}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"fbbfeb700295d1fe1ec6419a93594e5e1540ea32\", \"got_v8_revision\": \"336789833269d74f1c4fbd8f5e51714099fd032c\", \"got_v8_revision_cp\": \"refs/heads/8.1.39@{#1}\", \"got_webrtc_revision\": \"094396fb765d3e001644bb38cb922a664301e26e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30101}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f0221d2cf3f451d3731d4ff9214dabd4fdc00f79\", \"swarm_hashes_refs/heads/master(at){#725232}_without_patch\": {\"accessibility_unittests\": \"d9abf96377acd299d0722d58808809363e16e6aa\", \"angle_unittests\": \"e3b8175fa7ee01999e3a112b907715d1be517836\", \"app_shell_unittests\": \"45605e5e30235ec4819afc870b6e017def6c574f\", \"aura_unittests\": \"2c7871304a74845236a60769a0b5aaf740e5e660\", \"base_unittests\": \"db1be9fa87c0bfa66d0bb280bab97efed82e4a9d\", \"base_util_unittests\": \"e6791946406af3786da4fa1d664c6956568b5abf\", \"blink_common_unittests\": \"44bda3f78554437cca0fb38ddda50d3e15473934\", \"blink_fuzzer_unittests\": \"0d5f8af418ed7956b46e9a8f29fc49c2d022cfc6\", \"blink_heap_unittests\": \"d99fcd704eab75b3d0a16cca5c8ccf5b9f3d74b7\", \"blink_platform_unittests\": \"ac81ad998b34e01729fb11d9f6898a5e3c9cd3b6\", \"blink_python_tests\": \"6d1064fd94309af2ebba397f95d2c877ef074b42\", \"blink_unittests\": \"6a05f75cd52f95ff56e35a98e1c121478974936a\", \"blink_web_tests\": \"9fa173ed73607a5c40b4e61762771c4725c54428\", \"boringssl_crypto_tests\": \"7ad4ff2b1ab298d589868d14515505508eadda8c\", \"boringssl_ssl_tests\": \"f7adf21b51bb3cf953cbc88385f8a40d709b6e72\", \"browser_tests\": \"75c3fcf6781ae679ab6c334dc839eaaaa12395f5\", \"cacheinvalidation_unittests\": \"676e8246f75c7836508646a8fe8835fc358435b7\", \"capture_unittests\": \"90df6cad56208236b17e694be36f1eaef7d5f946\", \"cast_unittests\": \"26ca421d203317ad753d443b72a559725b314483\", \"cc_unittests\": \"517a6bccb0ac5d4f50d62391b9c34b87a75e5c55\", \"chrome_app_unittests\": \"6b3ac38d5cae009595754def02a06fe6e328d9da\", \"chromedriver_unittests\": \"b62d935200503c27882b120ad46f6cd16299021b\", \"components_browsertests\": \"a6cc8e1b8b171501dcbac62ab3c14482a373c11b\", \"components_unittests\": \"25bc65196b41b3c7674a6cb1cb54de6f76583c50\", \"compositor_unittests\": \"e03f121b8023c5b26676d805a776c3b3cd8e7521\", \"content_browsertests\": \"b1fbc13905cd9f0232a721af885c3f3c9eec5b01\", \"content_shell_crash_test\": \"74e5d48ee4966c8805356f4e0ad35dd630dc81ec\", \"content_unittests\": \"420e471b82db8dc0986aafef119c4918c83359d8\", \"crashpad_tests\": \"6aa2f32656466fa75a44047e35d0927b34f79e24\", \"cronet_tests\": \"84b4651475102c5be74430b13c23665c76dbeaec\", \"cronet_unittests\": \"39f91ba0020fb5f0edf0ab8e6ade92e9b7e4b5b8\", \"crypto_unittests\": \"ab6f7b66e0ae026bd4136a2c235a4e512cd858a2\", \"dbus_unittests\": \"d34a07af75ee8b5a31efa0444f5f506d82e57b9a\", \"device_unittests\": \"65980dfffcf8399531668bc10a94878e859b72f4\", \"devtools_lint_check\": \"e89cdebf802c0af0e411b0a4ddf755d863dae4d7\", \"devtools_type_check\": \"5c636320feb36915018f7e89bbd583cbbdb55b0b\", \"display_unittests\": \"5d8e77a93b9bf0ce566b9e79d4b11f5f5a54a53c\", \"events_unittests\": \"8264a2137f38d3d97ed8ea3fe87b6d0549af0c27\", \"extensions_browsertests\": \"f54bf133cf94a49c2d0ad7a0a3fafb2efa6e46df\", \"extensions_unittests\": \"9725a4d91acb9741dfca628fd42ac95b77105a22\", \"filesystem_service_unittests\": \"36306f3626b7741d1f32aeeb51de95068d3ad9be\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"3cafb7dbdd7f5dea2bae0a54bac1b30adb19099b\", \"gfx_unittests\": \"3921f6becaea89bdf6d79f327b30d9241eec8a61\", \"gin_unittests\": \"129cb432ab72aea08dfc574a72ee973ea58fdd73\", \"google_apis_unittests\": \"80e0f2dd934683b124b3a9dc6d0cf954524bae6f\", \"gpu_unittests\": \"68f91d98d1c53b3ddb643250d43205968d4f8631\", \"grit_python_unittests\": \"25dff9ef6327c596609d376409bc1d0e605b6d43\", \"gwp_asan_unittests\": \"e824ad38cfa20428e0beda6803f3976529a0e636\", \"headless_browsertests\": \"16abb0f83064ff3ead97f984f77555d9d371ec49\", \"headless_unittests\": \"a908105300892b58d446f69d63a2be429f6bf2ec\", \"interactive_ui_tests\": \"214a84053aeba9ac71a88df44ed24f5abcbfa1e5\", \"ipc_tests\": \"904b64b17fe77583faece3f2cdba492d56e7e64d\", \"jingle_unittests\": \"07f5290bc2105060c4c36b420aa4c43c501f8f85\", \"latency_unittests\": \"ecf625f2e1fad1e6109eeb702ced88fc06ae6e2b\", \"libjingle_xmpp_unittests\": \"8b0292216ecbbfdf7bc14a60025b9e1192f9c2aa\", \"media_blink_unittests\": \"797a0a5176d02fc02719347117920af093ed7466\", \"media_service_unittests\": \"67b4ad1bd113ac2fe50171b829edabf6d40bafaa\", \"media_unittests\": \"898b3acdae23508f083df0f0b9f931c590cedc1c\", \"message_center_unittests\": \"5af45584c28dba79eb7c42661a738999fdc0a6ad\", \"metrics_python_tests\": \"08db152ad33c251cfcd347c872da3d1c6f29b256\", \"midi_unittests\": \"18f23bbad9ba4d6e12a4044671878ef8e7006b4b\", \"mojo_core_unittests\": \"0983e458f7e49dd917c13247d1d308bbb220a39d\", \"mojo_unittests\": \"f7b5419764a72fe469b2d18594e9f36695c1ada7\", \"nacl_helper_nonsfi_unittests\": \"62207257d42997a80c7f061d100e94b4a47d492b\", \"nacl_loader_unittests\": \"549b8bba7d2902e38fda5dcc816ec3ac27580fd0\", \"native_theme_unittests\": \"9c33c90f7a2c6a914bbdb87258a748b3fcfd36da\", \"net_unittests\": \"0b289e11312948532c9a1bd4791d178bf113428d\", \"pdf_unittests\": \"b855fa9340e0d465ff3e13a7284bcaece135ebb4\", \"perfetto_unittests\": \"382690dd912e70e89a4c08f89401ab55ae85d132\", \"ppapi_unittests\": \"cc9eb8860902cbb78a7d433c179035d16ab1ab3c\", \"printing_unittests\": \"d48736a43134805f0c0b6c7ab18fe5dd35339eb3\", \"remoting_unittests\": \"aefa675bea709fd7e0a764cd7adafd4cb664ca45\", \"sandbox_linux_unittests\": \"e6d9bdc4cf7dbe88fb0ce468331b9dcd501460f9\", \"service_manager_unittests\": \"5b8e9961b11959259de1593085bf08212b0b68a2\", \"services_unittests\": \"b4e54c613abda08bb555e9ff9b51dc326e3f186d\", \"shell_dialogs_unittests\": \"e924bfe3565ae0a2f908291e35b614f07a30e61b\", \"skia_unittests\": \"0880f464f9d88c9019a71d849fa4600d05ac7a34\", \"snapshot_unittests\": \"a153a4307e28e7e9881b97686559e2bc1de45dd7\", \"sql_unittests\": \"7260301d555d3ace99ada04cc8d3dd70fd66b0e7\", \"storage_unittests\": \"df8713479d28bd64c7e3fb8ef3c5f0f21282f368\", \"sync_integration_tests\": \"4ccf8bae7e821f1e34d2ee2a38ae2202616d1d6f\", \"telemetry_gpu_unittests\": \"7e2b70c213438678114d8f4c57be9ac3335be73b\", \"telemetry_perf_unittests\": \"18f3b1f642e0a9cd572c024f442d724a9eb219c3\", \"telemetry_unittests\": \"0930af6549e30501da0a59238970007907edf2c7\", \"traffic_annotation_auditor_unittests\": \"01d6ec4979c78cade170bc348813f7f9e4d582a7\", \"ui_base_unittests\": \"78e3806e8d1e0a6dc20d4a82999734794a63c850\", \"ui_touch_selection_unittests\": \"8bf0967f0327104aaaf9bebb3c3d0f4e77599303\", \"unit_tests\": \"9bed9dbdf0b37560bf1eff3b52a2c943fdd70eea\", \"url_unittests\": \"138df635b9687f2cf949970fba25d1c661596d8f\", \"views_perftests\": \"c7b0a112a33199173c407f7f122db8bccdee79b5\", \"views_unittests\": \"10e503704a38553bfd035f03b4ca51adf0ad2054\", \"viz_unittests\": \"81c1bf564e59c043f93aeeb474c2941ae6a307bc\", \"vr_common_unittests\": \"26555b0368098f68c3507183c1fdad3d0797f1c7\", \"vr_pixeltests\": \"e9e11761e16980b78bc670e4ca2ccc6c0caf9036\", \"webdriver_wpt_tests\": \"c3453de1bd8f44c930d2fba92831960a00669f8a\", \"weblayer_browsertests\": \"0f2f65ced854f410e94dd154ce07e04b5eeeab92\", \"wm_unittests\": \"8672dc33d2fc6b06f8249b3af745cb00603acd7a\", \"wtf_unittests\": \"7d82503b65289a1dec83bd3f51131e14788ada36\", \"xr_browser_tests\": \"14785ac796659cf6e509ccfc2793c1ce87951832\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_df0918bfe72974da8c562c0af785205b640d6f631f017829e032ab97ab701012_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-86-d5pv\"], \"image\": [\"chrome-xenial-19120800-09d8782d9a1\"], \"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\": [\"4730-f2fc813\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1576527122938836",
"status": "COMPLETED",
"status_changed_ts": "1576530412884507",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166175",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f0221d2cf3f451d3731d4ff9214dabd4fdc00f79",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f0221d2cf3f451d3731d4ff9214dabd4fdc00f79",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059315568325560768",
"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/8893885505248060704/+/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:49292442dfc86710",
"user_agent:luci-scheduler"
],
"updated_ts": "1576530412898600",
"url": "https://ci.chromium.org/b/8893885505248060704",
"utcnow_ts": "1576530413955958"
}
}
[21:06:53.970] Invocation finished in 59m33.493476299s with status SUCCEEDED