[11:04:24.622] New invocation is queued and will start shortly
[11:04:25.805] Starting the invocation (attempt 1)
[11:04:25.848] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:04:25.848] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:04:25.848] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052826745044130208",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"41ab5275e827ddafda38dfd1711b3e43d6545649\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052826745044130208",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/41ab5275e827ddafda38dfd1711b3e43d6545649",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/41ab5275e827ddafda38dfd1711b3e43d6545649",
"gitiles_ref:refs/heads/master"
]
}
[11:04:27.743] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582715065943391",
"id": "8887396682971951680",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"41ab5275e827ddafda38dfd1711b3e43d6545649\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582715067591778",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169042",
"builder:Linux Builder (dbg)",
"buildset:commit/git/41ab5275e827ddafda38dfd1711b3e43d6545649",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/41ab5275e827ddafda38dfd1711b3e43d6545649",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052826745044130208",
"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/8887396682971951680/+/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": "1582715067591887",
"url": "https://ci.chromium.org/b/8887396682971951680",
"utcnow_ts": "1582715067733925"
}
}
[11:04:27.743] Task URL: https://ci.chromium.org/b/8887396682971951680
[11:04:27.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:2:0) after 1m0s
[11:05:27.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:2:0)
[11:05:27.774] Timer tick, asking Buildbucket for the build status
[11:05:27.971] Build 8887396682971951680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:05:27.971] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:3:0) after 1m0s
[11:06:28.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:3:0)
[11:06:28.062] Timer tick, asking Buildbucket for the build status
[11:06:28.227] Build 8887396682971951680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:06:28.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:4:0) after 1m0s
[11:07:28.259] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:4:0)
[11:07:28.259] Timer tick, asking Buildbucket for the build status
[11:07:28.396] Build 8887396682971951680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:07:28.396] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:5:0) after 1m0s
[11:08:28.469] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:5:0)
[11:08:28.469] Timer tick, asking Buildbucket for the build status
[11:08:28.700] Build 8887396682971951680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:08:28.700] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:6:0) after 1m0s
[11:09:02.310] Received PubSub notification, asking Buildbucket for the build status
[11:09:02.377] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:28.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:6:0)
[11:09:28.727] Timer tick, asking Buildbucket for the build status
[11:09:29.132] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:29.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:8:0) after 1m0s
[11:10:29.151] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:8:0)
[11:10:29.151] Timer tick, asking Buildbucket for the build status
[11:10:29.412] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:29.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:9:0) after 1m0s
[11:11:29.449] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:9:0)
[11:11:29.449] Timer tick, asking Buildbucket for the build status
[11:11:29.702] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:29.702] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:10:0) after 1m0s
[11:12:29.812] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:10:0)
[11:12:29.812] Timer tick, asking Buildbucket for the build status
[11:12:30.044] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:30.044] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:11:0) after 1m0s
[11:13:30.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:11:0)
[11:13:30.157] Timer tick, asking Buildbucket for the build status
[11:13:30.271] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:30.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:12:0) after 1m0s
[11:14:30.456] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:12:0)
[11:14:30.456] Timer tick, asking Buildbucket for the build status
[11:14:30.772] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:30.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:13:0) after 1m0s
[11:15:30.762] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:13:0)
[11:15:30.762] Timer tick, asking Buildbucket for the build status
[11:15:31.087] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:31.087] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:14:0) after 1m0s
[11:16:31.114] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:14:0)
[11:16:31.114] Timer tick, asking Buildbucket for the build status
[11:16:31.542] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:31.542] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:15:0) after 1m0s
[11:17:31.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:15:0)
[11:17:31.664] Timer tick, asking Buildbucket for the build status
[11:17:31.843] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:31.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:16:0) after 1m0s
[11:18:31.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:16:0)
[11:18:31.884] Timer tick, asking Buildbucket for the build status
[11:18:32.036] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:32.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:17:0) after 1m0s
[11:19:32.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:17:0)
[11:19:32.106] Timer tick, asking Buildbucket for the build status
[11:19:32.208] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:32.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:18:0) after 1m0s
[11:20:32.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:18:0)
[11:20:32.269] Timer tick, asking Buildbucket for the build status
[11:20:32.662] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:32.662] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:19:0) after 1m0s
[11:21:32.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:19:0)
[11:21:32.786] Timer tick, asking Buildbucket for the build status
[11:21:32.912] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:32.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:20:0) after 1m0s
[11:22:32.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:20:0)
[11:22:32.951] Timer tick, asking Buildbucket for the build status
[11:22:33.079] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:33.079] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:21:0) after 1m0s
[11:23:33.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:21:0)
[11:23:33.062] Timer tick, asking Buildbucket for the build status
[11:23:33.160] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:33.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:22:0) after 1m0s
[11:24:33.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:22:0)
[11:24:33.238] Timer tick, asking Buildbucket for the build status
[11:24:33.614] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:33.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:23:0) after 1m0s
[11:25:33.639] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:23:0)
[11:25:33.639] Timer tick, asking Buildbucket for the build status
[11:25:33.748] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:33.748] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:24:0) after 1m0s
[11:26:33.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:24:0)
[11:26:33.807] Timer tick, asking Buildbucket for the build status
[11:26:33.959] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:33.959] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:25:0) after 1m0s
[11:27:33.973] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:25:0)
[11:27:33.973] Timer tick, asking Buildbucket for the build status
[11:27:34.176] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:34.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:26:0) after 1m0s
[11:28:34.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:26:0)
[11:28:34.266] Timer tick, asking Buildbucket for the build status
[11:28:34.360] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:34.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:27:0) after 1m0s
[11:29:34.453] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:27:0)
[11:29:34.453] Timer tick, asking Buildbucket for the build status
[11:29:34.690] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:34.690] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:28:0) after 1m0s
[11:30:34.738] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:28:0)
[11:30:34.738] Timer tick, asking Buildbucket for the build status
[11:30:34.842] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:34.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:29:0) after 1m0s
[11:31:34.902] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:29:0)
[11:31:34.902] Timer tick, asking Buildbucket for the build status
[11:31:35.047] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:35.047] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:30:0) after 1m0s
[11:32:35.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:30:0)
[11:32:35.209] Timer tick, asking Buildbucket for the build status
[11:32:35.339] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:35.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:31:0) after 1m0s
[11:33:35.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:31:0)
[11:33:35.368] Timer tick, asking Buildbucket for the build status
[11:33:35.608] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:35.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:32:0) after 1m0s
[11:34:35.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:32:0)
[11:34:35.593] Timer tick, asking Buildbucket for the build status
[11:34:35.789] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:35.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:33:0) after 1m0s
[11:35:35.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:33:0)
[11:35:35.807] Timer tick, asking Buildbucket for the build status
[11:35:36.023] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:36.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:34:0) after 1m0s
[11:36:36.111] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:34:0)
[11:36:36.111] Timer tick, asking Buildbucket for the build status
[11:36:36.209] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:36.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:35:0) after 1m0s
[11:37:36.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:35:0)
[11:37:36.266] Timer tick, asking Buildbucket for the build status
[11:37:36.371] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:36.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:36:0) after 1m0s
[11:38:36.427] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:36:0)
[11:38:36.427] Timer tick, asking Buildbucket for the build status
[11:38:36.741] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:36.741] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:37:0) after 1m0s
[11:39:36.820] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:37:0)
[11:39:36.820] Timer tick, asking Buildbucket for the build status
[11:39:36.980] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:36.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:38:0) after 1m0s
[11:40:37.047] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:38:0)
[11:40:37.048] Timer tick, asking Buildbucket for the build status
[11:40:37.174] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:37.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:39:0) after 1m0s
[11:41:37.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:39:0)
[11:41:37.316] Timer tick, asking Buildbucket for the build status
[11:41:37.469] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:37.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:40:0) after 1m0s
[11:42:37.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:40:0)
[11:42:37.778] Timer tick, asking Buildbucket for the build status
[11:42:37.880] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:37.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:41:0) after 1m0s
[11:43:37.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:41:0)
[11:43:37.994] Timer tick, asking Buildbucket for the build status
[11:43:38.194] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:38.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:42:0) after 1m0s
[11:44:38.214] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:42:0)
[11:44:38.214] Timer tick, asking Buildbucket for the build status
[11:44:38.619] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:38.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:43:0) after 1m0s
[11:45:38.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:43:0)
[11:45:38.666] Timer tick, asking Buildbucket for the build status
[11:45:39.172] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:39.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:44:0) after 1m0s
[11:46:39.270] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:44:0)
[11:46:39.270] Timer tick, asking Buildbucket for the build status
[11:46:39.535] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:39.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:45:0) after 1m0s
[11:47:39.531] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:45:0)
[11:47:39.531] Timer tick, asking Buildbucket for the build status
[11:47:39.908] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:39.908] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:46:0) after 1m0s
[11:48:39.965] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:46:0)
[11:48:39.965] Timer tick, asking Buildbucket for the build status
[11:48:40.206] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:40.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:47:0) after 1m0s
[11:49:40.251] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:47:0)
[11:49:40.251] Timer tick, asking Buildbucket for the build status
[11:49:40.834] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:40.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:48:0) after 1m0s
[11:50:40.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:48:0)
[11:50:40.852] Timer tick, asking Buildbucket for the build status
[11:50:40.981] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:40.981] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:49:0) after 1m0s
[11:51:40.983] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:49:0)
[11:51:40.983] Timer tick, asking Buildbucket for the build status
[11:51:41.106] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:41.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:50:0) after 1m0s
[11:52:41.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:50:0)
[11:52:41.192] Timer tick, asking Buildbucket for the build status
[11:52:41.337] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:41.337] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:51:0) after 1m0s
[11:53:41.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:51:0)
[11:53:41.406] Timer tick, asking Buildbucket for the build status
[11:53:41.536] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:41.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:52:0) after 1m0s
[11:54:41.565] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:52:0)
[11:54:41.565] Timer tick, asking Buildbucket for the build status
[11:54:41.727] Build 8887396682971951680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:41.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052826745044130208:53:0) after 1m0s
[11:54:55.065] Received PubSub notification, asking Buildbucket for the build status
[11:54:55.317] Build 8887396682971951680: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:54:55.318] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582718093924027",
"created_by": "project:chromium",
"created_ts": "1582715065943391",
"id": "8887396682971951680",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"41ab5275e827ddafda38dfd1711b3e43d6545649\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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-2-u94s\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169042, \"got_angle_revision\": \"908dc2208b7c36698bf0c010350799a729f46c1a\", \"got_dawn_revision\": \"2f0f850da8aab8ce4e5cde2e83f91421e559456d\", \"got_nacl_revision\": \"021c8b6784ea41113fe6d54f36359a0c329a5cc5\", \"got_revision\": \"41ab5275e827ddafda38dfd1711b3e43d6545649\", \"got_revision_cp\": \"refs/heads/master@{#744603}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"da659b3741132fe6a6904e45d96112eef776bc28\", \"got_v8_revision\": \"6736f968b293a4dc2119f246fecac8956579e302\", \"got_v8_revision_cp\": \"refs/heads/8.2.184@{#1}\", \"got_webrtc_revision\": \"a6db9c8fe9276774e3939d577c9320ad00fddd83\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30613}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"41ab5275e827ddafda38dfd1711b3e43d6545649\", \"swarm_hashes_refs/heads/master(at){#744603}_without_patch\": {\"accessibility_unittests\": \"f76cd294c666a0df797bd4ff2f59de4f8d98ac99\", \"angle_unittests\": \"d0b18331e4bb962bcc6931af0d05fa2832d2fae4\", \"app_shell_unittests\": \"d6727aadd57209be3c506746af0d66818cf8b052\", \"aura_unittests\": \"9e5c3d14c1bfcb07e6310f0acd090dfd354af0cc\", \"base_unittests\": \"374767930c8a1db23034ae6ecc4b4df63881f812\", \"base_util_unittests\": \"f2a3e5fe02659a290668e9eddbfa56387c9496c4\", \"blink_common_unittests\": \"c0985c519d8a79f4341f555ca524556bb62c3a0f\", \"blink_fuzzer_unittests\": \"5c58e8306603fca9a84ab6dcc3a49d06bff4c6e0\", \"blink_heap_unittests\": \"5235e674ea05ba95b8d983e78aa197b8c4234723\", \"blink_platform_unittests\": \"5384fe1b6f37c855254cf24e127d86515736c4bf\", \"blink_python_tests\": \"bca77ab4a3bdc4ca763dca829c6baee146cac25c\", \"blink_unittests\": \"50966df70172d217a5ea5ccb1498cf9d9ed18c89\", \"blink_web_tests\": \"11cdc192dad0946e3620bdac65ef435101dcbf42\", \"boringssl_crypto_tests\": \"645c02bf39dae19547f5513dc91cf3121f370bc5\", \"boringssl_ssl_tests\": \"680b545f58a53d5f14df6792969b6bf4226f2cd6\", \"browser_tests\": \"1116b5639a6c43c5d9fceafa7999741409c30ecb\", \"cacheinvalidation_unittests\": \"0340a0ffea3aa6050f1283cc35b9bae0ae565951\", \"capture_unittests\": \"33b402dc1db8614f28106bb2bc1608cff5a93e45\", \"cast_unittests\": \"573cf167259e76180c764e7776e2945a37b22b72\", \"cc_unittests\": \"9ce56ef97b8bfb0882fe001619694ab1f7c0de42\", \"chrome_app_unittests\": \"9a8b536bbb0f4f4c16b9523bf099ebbfc04ba5ea\", \"chromedriver_unittests\": \"bce40f699aa7757e39537a603f5d328d393346a7\", \"components_browsertests\": \"3cae4ad9b3672416cda8111746acaffab51372e5\", \"components_unittests\": \"702f4e33873d9d5524121031cf8707b2fe2f886e\", \"compositor_unittests\": \"2c9476e8ae7e0db568a72e227fe7f49fcd07f1e8\", \"content_browsertests\": \"78263979ac97e954f6a56564fcda01968edc4a7d\", \"content_shell_crash_test\": \"1c9a41b819a1e917f57b2c0ed50fe5404a205151\", \"content_unittests\": \"2ae42467111c2b67e64687f61ccd40a76d2d4969\", \"crashpad_tests\": \"52335fcbe2846a4f04c4973574ff2c35ba7695f4\", \"cronet_tests\": \"e29f5972eb14162c80f789166474dc5aa89b408d\", \"cronet_unittests\": \"08c9d60a55c36f1ed551e5a8327ffb2ad6855d37\", \"crypto_unittests\": \"4209ffb1829140412c01b5fb5dfc9db66cdc5a64\", \"dbus_unittests\": \"a1faf5babb02551015ccba38832091bca700a399\", \"device_unittests\": \"f47cefa1e17370a91491b8e83c3a5651440c858b\", \"display_unittests\": \"aa040e39fafb85edfa8c581fe0ed81d7bff0d318\", \"events_unittests\": \"b3e0203c5dbd4b263b8156880534960e70d840ee\", \"extensions_browsertests\": \"3286b8fed00af1f410de72555093a1519bcfc34b\", \"extensions_unittests\": \"ebc654f08c182f15d4bfc8b30fd7cfa64a5c52c4\", \"filesystem_service_unittests\": \"4342b3e6831e2743ebbd619269ec5d9b2c1edd15\", \"flatbuffers_unittests\": \"fddfee5d9c5c5357203fa42dff8f3c357607bc22\", \"gcm_unit_tests\": \"9cf9c7e02528b88f4b807d4ab36fc0ca441b8017\", \"gfx_unittests\": \"a3d205e91cdc002f21a20fd938ae13861033db50\", \"gin_unittests\": \"55aeb67c28da488a65aa1fb6dc89214428557077\", \"google_apis_unittests\": \"32d704b37e874e85e4fa0f4e57ef06f5f7279d6a\", \"gpu_unittests\": \"c945d8d1505caa2fa01eb7664097da269930649d\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"f9931a1c16bf0385d9a1e68694ebb3efa12b0be6\", \"headless_browsertests\": \"cadcab8e53256a4631c3250d4bf64e0395642575\", \"headless_unittests\": \"3e21b5068cf7595757e666124b19bb9fac3cd662\", \"interactive_ui_tests\": \"2e20b0e6823b43345df795232622421a6ef2b2f4\", \"ipc_tests\": \"e0f7b187ef2401acfa60df4d22f697e52091f20d\", \"jingle_unittests\": \"f3cf98c2ff377a669bbb62b0e51de8bad8e727d5\", \"latency_unittests\": \"261a0e01a3662796e54f6f9b88383293a1bcceb7\", \"libjingle_xmpp_unittests\": \"f161e3c75b454e72ff0fc0b413426003ef953725\", \"media_blink_unittests\": \"455a14cdfdc380d0242fbd1ecdaac392f23b739f\", \"media_service_unittests\": \"0367d34b3e3ba3bc4330464b20de745dfcb99ce1\", \"media_unittests\": \"2bcea65086d84e493e919ef0cc3747cab1c8062e\", \"message_center_unittests\": \"610548ccc09f236b7aa8ccafdd63e131956fb0dd\", \"metrics_python_tests\": \"4dc27e65b4bdc0420d2d1e7a51423d1b369811e5\", \"midi_unittests\": \"92e38fcae417ef84dc10be69add165231ccf5ba2\", \"mojo_core_unittests\": \"1bb1e648ef92fa8977968ad2744e53982c4ec9b6\", \"mojo_unittests\": \"00d7d2dc77b810a3bcb8a6e1fe77d078326fd842\", \"nacl_helper_nonsfi_unittests\": \"f2e81d6cb41bb06d2bdca4a2ed0d77f22a887857\", \"nacl_loader_unittests\": \"84e97b32a086858448e284830362ead88c90cb0a\", \"native_theme_unittests\": \"170fc4d4414ba302cfe2d95fc36962a4ee3ea779\", \"net_unittests\": \"f18992e58b06a316d3e90495502cd84ae43c6f6b\", \"pdf_unittests\": \"09d8bc132b9175708daff64fb033a4009f780dbc\", \"perfetto_unittests\": \"a342937254cacf69269a4fc2c69c97c27ac25a92\", \"ppapi_unittests\": \"4921dac4c4137ca6006b05f1ccb096f1599d0959\", \"printing_unittests\": \"340fc7759846c5858476b4dfdd5b12a888a134aa\", \"remoting_unittests\": \"cd8af292c18c0f25ec276e0fc5602ec99618f07b\", \"sandbox_linux_unittests\": \"982bef5f630b96d488bb8d52d6c3a0af9d30a657\", \"service_manager_unittests\": \"745d2bd96cbd26b1fbc6d471b20a7b6a36b2372a\", \"services_unittests\": \"756fa565b6065043adef39095849d3b21dd7a9c7\", \"shell_dialogs_unittests\": \"29b4d72577f9ceda31f1820459c4c4bf926767a2\", \"skia_unittests\": \"afa5d298ae9dd45a839295034fd982a61d64c6bc\", \"snapshot_unittests\": \"c383fbbacc830a5d028e3a63831764ccfe004465\", \"sql_unittests\": \"3e3bc20e2d831bae044cd01f0f80041320572d1e\", \"storage_unittests\": \"4ae74b5bbbf7e8f290f9f38dca32ccd9c35e32c1\", \"sync_integration_tests\": \"a5c431abbc9be9498feb7a214689bf1d09d61a13\", \"telemetry_gpu_unittests\": \"e3f2e805dc8d6c736b4af335571f1b436fd89996\", \"telemetry_perf_unittests\": \"7860a37a8674d6d88ce6d8685edcd6d608ce179a\", \"telemetry_unittests\": \"88863bf58cb06f50df72fccc2d4e08591947de7f\", \"traffic_annotation_auditor_unittests\": \"7bac54b8d589cf726834e4c483137365f97bf2dd\", \"ui_base_unittests\": \"b1d676c93ecc2795689fff97fcb8a75d27315c7a\", \"ui_touch_selection_unittests\": \"45f4a0a28d6a45855009f51f83d7a10343cf2923\", \"unit_tests\": \"79903f3797888b7f8d0271988af94ae78afe25fe\", \"url_unittests\": \"3f5171bd43e3cac3eaac90164cae30b03b570e9c\", \"views_perftests\": \"db0122adbcef2a8801b1a39437547eb29c29deaa\", \"views_unittests\": \"87886d9e1cebc6a3d00b5feda20f4bbb5eea70c2\", \"viz_unittests\": \"16fdfc7604515d1d7dc0e56104779da35c84d914\", \"vr_common_unittests\": \"40f38202ecfadd3973c17732ae0f016e3c63344b\", \"vr_pixeltests\": \"c3cfea5367742b742f5fb0a0da2e91a1592c7769\", \"webdriver_wpt_tests\": \"6e610310f52e81f6c0d831fc98f4513a0cd2ac42\", \"weblayer_browsertests\": \"054e5108856924a16087f314a6598812583a8f23\", \"wm_unittests\": \"b657191b415f037bde7449a0c5bbb4dcb5169ef7\", \"wtf_unittests\": \"6bffdeb5bfa523f4cba826a2ca87005a57208d0f\", \"xr_browser_tests\": \"52f56d62512af53bfc97f619d8964a053abe66da\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3ebf4dd509a5805e98d79f047f39cac1c13d897e075c42798b95fb1279fe5d7c_v2\", \"builder_65fafd0c860c8cf0043a2ec0f6482d6e089dd429d22310040aa34c8b96106827_v2\", \"builder_f5610824250c57fc28679fbc8606252c3dbaca731fb7f2a4bebf1e0fc7f48a3a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-2-u94s\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4838-b69615e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582715341640430",
"status": "COMPLETED",
"status_changed_ts": "1582718094405146",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169042",
"builder:Linux Builder (dbg)",
"buildset:commit/git/41ab5275e827ddafda38dfd1711b3e43d6545649",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/41ab5275e827ddafda38dfd1711b3e43d6545649",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052826745044130208",
"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/8887396682971951680/+/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:4a99fce630c8fc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1582718094408565",
"url": "https://ci.chromium.org/b/8887396682971951680",
"utcnow_ts": "1582718095248601"
}
}
[11:54:55.318] Invocation finished in 50m30.734779848s with status SUCCEEDED