[17:15:12.552] New invocation is queued and will start shortly
[17:15:13.980] Starting the invocation (attempt 1)
[17:15:14.019] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:15:14.020] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:15:14.020] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9061591322120821120",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"00ac734085d734d81b6e901c0a6fdc4f91d704ab\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9061591322120821120",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/00ac734085d734d81b6e901c0a6fdc4f91d704ab",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/00ac734085d734d81b6e901c0a6fdc4f91d704ab",
"gitiles_ref:refs/heads/master"
]
}
[17:15:14.762] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1574356514225961",
"id": "8896161259697803664",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"00ac734085d734d81b6e901c0a6fdc4f91d704ab\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1574356514589068",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165117",
"builder:Linux Builder (dbg)",
"buildset:commit/git/00ac734085d734d81b6e901c0a6fdc4f91d704ab",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/00ac734085d734d81b6e901c0a6fdc4f91d704ab",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061591322120821120",
"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/8896161259697803664/+/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": "1574356514589218",
"url": "https://ci.chromium.org/b/8896161259697803664",
"utcnow_ts": "1574356514750431"
}
}
[17:15:14.762] Task URL: https://ci.chromium.org/b/8896161259697803664
[17:15:14.762] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:2:0) after 1m0s
[17:15:59.618] Received PubSub notification, asking Buildbucket for the build status
[17:15:59.895] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:14.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:2:0)
[17:16:14.782] Timer tick, asking Buildbucket for the build status
[17:16:15.810] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:15.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:4:0) after 1m0s
[17:17:15.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:4:0)
[17:17:15.823] Timer tick, asking Buildbucket for the build status
[17:17:16.731] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:16.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:5:0) after 1m0s
[17:18:16.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:5:0)
[17:18:16.756] Timer tick, asking Buildbucket for the build status
[17:18:17.530] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:17.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:6:0) after 1m0s
[17:19:17.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:6:0)
[17:19:17.679] Timer tick, asking Buildbucket for the build status
[17:19:18.882] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:18.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:7:0) after 1m0s
[17:20:18.892] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:7:0)
[17:20:18.892] Timer tick, asking Buildbucket for the build status
[17:20:19.126] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:19.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:8:0) after 1m0s
[17:21:19.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:8:0)
[17:21:19.166] Timer tick, asking Buildbucket for the build status
[17:21:19.463] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:19.464] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:9:0) after 1m0s
[17:22:19.554] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:9:0)
[17:22:19.554] Timer tick, asking Buildbucket for the build status
[17:22:19.745] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:19.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:10:0) after 1m0s
[17:23:19.840] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:10:0)
[17:23:19.840] Timer tick, asking Buildbucket for the build status
[17:23:20.376] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:20.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:11:0) after 1m0s
[17:24:20.370] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:11:0)
[17:24:20.370] Timer tick, asking Buildbucket for the build status
[17:24:21.222] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:21.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:12:0) after 1m0s
[17:25:21.256] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:12:0)
[17:25:21.256] Timer tick, asking Buildbucket for the build status
[17:25:21.735] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:21.735] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:13:0) after 1m0s
[17:26:21.771] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:13:0)
[17:26:21.771] Timer tick, asking Buildbucket for the build status
[17:26:23.241] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:23.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:14:0) after 1m0s
[17:27:23.356] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:14:0)
[17:27:23.356] Timer tick, asking Buildbucket for the build status
[17:27:23.597] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:23.597] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:15:0) after 1m0s
[17:28:23.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:15:0)
[17:28:23.693] Timer tick, asking Buildbucket for the build status
[17:28:24.478] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:24.478] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:16:0) after 1m0s
[17:29:24.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:16:0)
[17:29:24.551] Timer tick, asking Buildbucket for the build status
[17:29:25.449] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:25.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:17:0) after 1m0s
[17:30:25.476] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:17:0)
[17:30:25.476] Timer tick, asking Buildbucket for the build status
[17:30:25.970] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:25.970] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:18:0) after 1m0s
[17:31:26.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:18:0)
[17:31:26.048] Timer tick, asking Buildbucket for the build status
[17:31:26.313] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:26.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:19:0) after 1m0s
[17:32:26.444] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:19:0)
[17:32:26.444] Timer tick, asking Buildbucket for the build status
[17:32:26.638] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:26.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:20:0) after 1m0s
[17:33:26.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:20:0)
[17:33:26.655] Timer tick, asking Buildbucket for the build status
[17:33:26.810] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:26.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:21:0) after 1m0s
[17:34:26.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:21:0)
[17:34:26.835] Timer tick, asking Buildbucket for the build status
[17:34:27.494] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:27.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:22:0) after 1m0s
[17:35:27.571] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:22:0)
[17:35:27.571] Timer tick, asking Buildbucket for the build status
[17:35:27.856] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:27.856] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:23:0) after 1m0s
[17:36:27.899] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:23:0)
[17:36:27.899] Timer tick, asking Buildbucket for the build status
[17:36:28.418] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:28.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:24:0) after 1m0s
[17:37:28.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:24:0)
[17:37:28.477] Timer tick, asking Buildbucket for the build status
[17:37:31.334] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:31.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:25:0) after 1m0s
[17:38:31.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:25:0)
[17:38:31.355] Timer tick, asking Buildbucket for the build status
[17:38:31.614] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:31.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:26:0) after 1m0s
[17:39:31.900] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:26:0)
[17:39:31.901] Timer tick, asking Buildbucket for the build status
[17:39:32.158] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:32.158] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:27:0) after 1m0s
[17:40:32.715] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:27:0)
[17:40:32.715] Timer tick, asking Buildbucket for the build status
[17:40:33.436] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:33.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:28:0) after 1m0s
[17:41:33.858] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:28:0)
[17:41:33.858] Timer tick, asking Buildbucket for the build status
[17:41:35.235] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:35.235] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:29:0) after 1m0s
[17:42:35.758] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:29:0)
[17:42:35.758] Timer tick, asking Buildbucket for the build status
[17:42:35.959] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:35.959] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:30:0) after 1m0s
[17:43:36.251] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:30:0)
[17:43:36.251] Timer tick, asking Buildbucket for the build status
[17:43:36.500] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:36.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:31:0) after 1m0s
[17:44:36.768] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:31:0)
[17:44:36.768] Timer tick, asking Buildbucket for the build status
[17:44:37.716] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:37.716] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:32:0) after 1m0s
[17:45:38.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:32:0)
[17:45:38.043] Timer tick, asking Buildbucket for the build status
[17:45:38.744] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:38.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:33:0) after 1m0s
[17:46:38.769] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:33:0)
[17:46:38.769] Timer tick, asking Buildbucket for the build status
[17:46:38.897] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:38.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:34:0) after 1m0s
[17:47:39.335] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:34:0)
[17:47:39.335] Timer tick, asking Buildbucket for the build status
[17:47:39.675] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:39.675] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:35:0) after 1m0s
[17:48:39.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:35:0)
[17:48:39.801] Timer tick, asking Buildbucket for the build status
[17:48:40.012] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:40.012] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:36:0) after 1m0s
[17:49:40.152] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:36:0)
[17:49:40.152] Timer tick, asking Buildbucket for the build status
[17:49:40.330] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:40.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:37:0) after 1m0s
[17:50:40.468] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:37:0)
[17:50:40.468] Timer tick, asking Buildbucket for the build status
[17:50:40.849] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:40.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:38:0) after 1m0s
[17:51:40.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:38:0)
[17:51:40.871] Timer tick, asking Buildbucket for the build status
[17:51:41.498] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:41.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:39:0) after 1m0s
[17:52:41.683] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:39:0)
[17:52:41.683] Timer tick, asking Buildbucket for the build status
[17:52:42.182] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:42.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:40:0) after 1m0s
[17:53:42.227] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:40:0)
[17:53:42.227] Timer tick, asking Buildbucket for the build status
[17:53:42.351] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:42.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:41:0) after 1m0s
[17:54:42.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:41:0)
[17:54:42.492] Timer tick, asking Buildbucket for the build status
[17:54:42.951] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:42.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:42:0) after 1m0s
[17:55:43.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:42:0)
[17:55:43.064] Timer tick, asking Buildbucket for the build status
[17:55:43.411] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:43.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:43:0) after 1m0s
[17:56:43.613] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:43:0)
[17:56:43.613] Timer tick, asking Buildbucket for the build status
[17:56:43.732] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:43.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:44:0) after 1m0s
[17:57:44.494] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:44:0)
[17:57:44.494] Timer tick, asking Buildbucket for the build status
[17:57:44.844] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:44.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:45:0) after 1m0s
[17:58:45.006] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:45:0)
[17:58:45.006] Timer tick, asking Buildbucket for the build status
[17:58:45.211] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:45.211] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:46:0) after 1m0s
[17:59:45.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:46:0)
[17:59:45.663] Timer tick, asking Buildbucket for the build status
[17:59:45.967] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:45.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:47:0) after 1m0s
[18:00:46.453] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:47:0)
[18:00:46.453] Timer tick, asking Buildbucket for the build status
[18:00:47.302] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:47.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:48:0) after 1m0s
[18:01:47.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:48:0)
[18:01:47.434] Timer tick, asking Buildbucket for the build status
[18:01:48.636] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:48.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:49:0) after 1m0s
[18:02:48.697] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:49:0)
[18:02:48.697] Timer tick, asking Buildbucket for the build status
[18:02:48.944] Build 8896161259697803664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:48.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061591322120821120:50:0) after 1m0s
[18:03:11.884] Received PubSub notification, asking Buildbucket for the build status
[18:03:12.041] Build 8896161259697803664: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:03:12.041] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1574359390637200",
"created_by": "project:chromium",
"created_ts": "1574356514225961",
"id": "8896161259697803664",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"00ac734085d734d81b6e901c0a6fdc4f91d704ab\"}}",
"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-26-j9t4\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 165117, \"got_angle_revision\": \"1898c08274eb3cf630999799f939c345e1cef813\", \"got_dawn_revision\": \"0d4a7b0ba5b73425c1c5aa641843f971f0bdda4d\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"00ac734085d734d81b6e901c0a6fdc4f91d704ab\", \"got_revision_cp\": \"refs/heads/master@{#717684}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"72e68083f914fb2904f19d7118f0ce397cb6e9d3\", \"got_v8_revision\": \"96bd79e5ddf97d6e48b1774ca953bf4084d1e93a\", \"got_v8_revision_cp\": \"refs/heads/8.0.329@{#1}\", \"got_webrtc_revision\": \"b86a1770ee648751ea0cb8a1d8b8cc8db14e6798\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29855}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"00ac734085d734d81b6e901c0a6fdc4f91d704ab\", \"swarm_hashes_refs/heads/master(at){#717684}_without_patch\": {\"accessibility_unittests\": \"191999dc0c132eeeca7c3829210a052ba93f1cb9\", \"angle_unittests\": \"fe623d2665dc9efe63e361a0721b16edee0c6003\", \"app_shell_unittests\": \"c6627715b0b590f036d4469562d64d94cc6e0d5f\", \"aura_unittests\": \"69c97c415ee228648a3d7706b3beb76daec1738f\", \"base_unittests\": \"a340aafc95fc8ef4dee6370dfb370c3726c2d635\", \"base_util_unittests\": \"3ce148564ac849dd54323f47ffbaf73feb7198fa\", \"blink_common_unittests\": \"f2c247011413241acb90769cc1d4c62bcce6cf56\", \"blink_fuzzer_unittests\": \"9c4f3a7509e231ac4e5806b34d77aa6e40a41e43\", \"blink_heap_unittests\": \"5e3a5db23c51dfec57bfba2c6267d0bb92dbe93f\", \"blink_platform_unittests\": \"a5017ac97723753da3ce96347c5c2f6f9d684a95\", \"blink_python_tests\": \"7af00be87ac7eb5111f15859051394f026b59ef3\", \"blink_unittests\": \"ae738f8896b9c84d40b7f2d131866ed5c4e4a2b3\", \"blink_web_tests_exparchive\": \"1b8e7056a2931e0f5dad183d37e1602b31544f20\", \"boringssl_crypto_tests\": \"8245e775fcfbda8aba6d201f9c7fc8a8d0947a37\", \"boringssl_ssl_tests\": \"8fe67dd6fd9beb4f4ad8cc8c85d0bc92126b2087\", \"browser_tests\": \"047da7f89ed4613696c6668af6b305dbf75cd28d\", \"cacheinvalidation_unittests\": \"91b5c4f0290125e8820921f9f0501dbedce804fb\", \"capture_unittests\": \"a509ca052b15d35277c59010229624923954959b\", \"cast_unittests\": \"3602e8e70152856d151be70d86a1781bddf7144f\", \"cc_unittests\": \"233627e1fdf6f19f2492175079777607c942d64b\", \"chrome_app_unittests\": \"c787c53efae05b6a7a386dce03f9e51603375739\", \"chromedriver_unittests\": \"54b1c453e966dfbdaaf1285f72fa26eb697b9289\", \"color_unittests\": \"a596b0a2f08aab4d92efc2e356c82f68e2e8a9c2\", \"components_browsertests\": \"541f23b6c6118514b9f8b68c8a3961a69968dfd5\", \"components_unittests\": \"a68ee73f26037565627a1cf925d4ba3bc2efcf47\", \"compositor_unittests\": \"a7ccf500aa6d6478ea44dc9672c2027ce94b03c1\", \"content_browsertests\": \"af178c04c9366c62dfbd0e723ef3c8081e727aaa\", \"content_shell_crash_test\": \"d9a592a83d93f988282b44b7854ae8f0a948fc5d\", \"content_unittests\": \"7ccb50a896d000d2cfd78366d19eda6042363808\", \"crashpad_tests\": \"42c8f6d38eb51731ccd39cc07080d64205c5e8b3\", \"cronet_tests\": \"a638743276007bbc487da669062281c4c860ea91\", \"cronet_unittests\": \"2f9dc0c25f4e86d025a19fb1077ad8c06e454284\", \"crypto_unittests\": \"aef26864bbe7b64f32c801d2ab72dc3e3aa5d6d9\", \"dbus_unittests\": \"15b9308c79f0abc4e67a2cfc3142b87aef63e37f\", \"device_unittests\": \"4bcba133c7ce98e8a744ac45232ff6dcef6e65cf\", \"devtools_lint_check\": \"cd702703f13611c997d560afdb86217d27a15fb5\", \"devtools_type_check\": \"5591eb775c4e5382154c74bb0b755154e4a48316\", \"display_unittests\": \"52287b6fba4aa297860bb11f87ab1cd285efc72c\", \"events_unittests\": \"028c2e85b3fcc80a926c8d6c71ce976be01899a5\", \"extensions_browsertests\": \"d5703dcd0b9a8d1bf840a4e1c2e0dac7280cc9ca\", \"extensions_unittests\": \"1550e2f3b61b706d56f4aca2d9c754fc93cb8f12\", \"filesystem_service_unittests\": \"97bc61d8aff7502c2ea9d763c8b4fd968d15d82b\", \"flatbuffers_unittests\": \"68877d8b1262b0aa771438df1015a16a10098d5e\", \"gcm_unit_tests\": \"400b927470543c0fe302add57d1fdfe50bd3a2f3\", \"gfx_unittests\": \"80904cd8eab5236c3050db007c0f83a6f578385f\", \"gin_unittests\": \"ce9d6c8840c269b2c934cef0dac56a0624ea7241\", \"google_apis_unittests\": \"b73f813573cfb2df153cb91cc61f46e87bb6b989\", \"gpu_unittests\": \"30adf9d4896da923965eaeb0cb3d8f2084cb639d\", \"grit_python_unittests\": \"4267cdfe96cbb5881cc25cc5b15aab4b2f28c5f5\", \"gwp_asan_unittests\": \"3454441992a960dcd5e24e1f2724c61d8570b451\", \"headless_browsertests\": \"e7795d1b618b82b4941e40a940b613f3fddbdec7\", \"headless_unittests\": \"449cc13b18c34cae149a8cb318d121e113596057\", \"interactive_ui_tests\": \"5f0e06a3dacc4fa5d127035a8e183361765280b9\", \"ipc_tests\": \"8d643780673828abc1b73888aca0d194f5bb0e5f\", \"jingle_unittests\": \"bea2e3e33f8dfe9c45474b4ac4c3c7474fcb7f55\", \"latency_unittests\": \"28e54a1cf25b29b7c97d0b77fc4e44515704a0cd\", \"libjingle_xmpp_unittests\": \"ed7a4bc2e22e2c6d288da3407deaa8e65a3ab659\", \"media_blink_unittests\": \"9ea725b2fc7f8c83e970f9ad3e1a8cf5043cba25\", \"media_service_unittests\": \"26346467801eed36ce36cd90d8f16013c517014d\", \"media_unittests\": \"52b3e9ecfeb47f551176a19521b0c81ebfb12cfc\", \"message_center_unittests\": \"919c92893fd54f7e5b0950aa6c58185e2abd8547\", \"metrics_python_tests\": \"24abaa1d78faa5764c33a233e8b8511bb3b027a0\", \"midi_unittests\": \"f1971ac322827378e2cb694ee4146028a17d6c7e\", \"mojo_core_unittests\": \"c252dd8672d1784303f80d2438de5b309df738ad\", \"mojo_unittests\": \"e8e670d134237b5be3dd1a9c4b7af88fc2814a37\", \"nacl_helper_nonsfi_unittests\": \"68fce67f17ade6d2683d93df1c44cd730b4336a4\", \"nacl_loader_unittests\": \"2ef5fc6778840569c3a988862cd0f33c049793c8\", \"native_theme_unittests\": \"f13acf9e0d1144d2e200a4bb25ac175e1b004e35\", \"net_unittests\": \"2589d43b207d08f21dc1dfe915c8079ecd47b58d\", \"pdf_unittests\": \"e96004fd1b565784c5833800f0261e0ead8a0b5f\", \"perfetto_unittests\": \"0111024a78bdd0cf1f169f60baf863675518e243\", \"ppapi_unittests\": \"f3f7cd62405003cca7ed3096bf2dad64c4e29286\", \"printing_unittests\": \"d77fcbe1d9968dc28191de49b846fcb6cbe5750d\", \"remoting_unittests\": \"38341213de09e98dade35282342d0d2d6e5c15cc\", \"sandbox_linux_unittests\": \"413692bc8cb65a9313a9e55541eab41c22d5959b\", \"service_manager_unittests\": \"f92c0d3fe4d95f5b898ddb8a786b144859bd0f49\", \"services_unittests\": \"7d60c0b05816fefc5a6477c26e95e6ea32e6d8f7\", \"shell_dialogs_unittests\": \"8d0e7a3cc43177b26ad53bbecbd4f98e77fa0306\", \"skia_unittests\": \"8c5620845243b5cd5c45f15b39eff540eef0eb3c\", \"snapshot_unittests\": \"e997aff07cc6962a6ff4f8082b83f5aa70957b46\", \"sql_unittests\": \"10c632e2284c2b1ba33aac9e423eb48c5abd1154\", \"storage_unittests\": \"7680bfae5affea128d13b7c7742f307c94c7acaa\", \"sync_integration_tests\": \"bc3fd0f98ab45b0986ac4f307ec91a78bc0c5ac0\", \"telemetry_gpu_unittests\": \"e0853b1a9f5a3966e4f1659491363034030c8b6e\", \"telemetry_perf_unittests\": \"54e859cdceb251aabc83e66a62ead133559c595d\", \"telemetry_unittests\": \"c3e70e535a9ae5ff0befc09ee730418281a0f1c9\", \"traffic_annotation_auditor_unittests\": \"6a31616653da03330dbe4a81ca6c3e7c1357a434\", \"ui_base_unittests\": \"fb8da12b0c01c17df44692a5dfff6ed1e0206b4a\", \"ui_touch_selection_unittests\": \"ab1edc3f956263f6e6392275c5922d8b9dd98997\", \"unit_tests\": \"77ee0bae384b9b614a6ee9d8012617d5f51489ac\", \"url_unittests\": \"4f5088cbd6fb381db233162b9014f53213cced1a\", \"views_perftests\": \"03a36c7e59f7c4288104f6502d19fe387eec719b\", \"views_unittests\": \"8889b7677f19e55dd7166cee8377f6b881c7c5d4\", \"viz_unittests\": \"e5d0e5e139628aa7be64162733aa58ff8d4be2bf\", \"vr_common_unittests\": \"367f3c5952d02933681ce35e1b1282a9fca7354f\", \"vr_pixeltests\": \"a69374a06d247b1e1ccd77645d4100fbad380a2c\", \"webdriver_wpt_tests\": \"b0cda8d5c38702981fb8b4cf23c56b92bb3a70e2\", \"weblayer_browsertests\": \"7712dcbb80f17178b20cfc96cc616cf11c91595a\", \"wm_unittests\": \"2a125c8cad354638ea37ce9c7754d451239cbf1e\", \"wtf_unittests\": \"5ed5f337484d3ee3e3ec81e103203c3343236027\", \"xr_browser_tests\": \"6612ff21e6230ccbe7b06617b1ca5b15e44638d3\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3f2e634b0c5b6fb0621aa33ddfc8c7ed92b6a5273976770439117724e11f428e_v2\", \"builder_73a5b2ce307b316a1240917eaad41a92e4adc44903c6789e05a5f10300306cda_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-26-j9t4\"], \"image\": [\"chrome-xenial-19111704-ac4c24a5ee0\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4645-7f6a85d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1574356558786530",
"status": "COMPLETED",
"status_changed_ts": "1574359391103304",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165117",
"builder:Linux Builder (dbg)",
"buildset:commit/git/00ac734085d734d81b6e901c0a6fdc4f91d704ab",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/00ac734085d734d81b6e901c0a6fdc4f91d704ab",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061591322120821120",
"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/8896161259697803664/+/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:48a7c7f8a70c0f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1574359391118078",
"url": "https://ci.chromium.org/b/8896161259697803664",
"utcnow_ts": "1574359392022882"
}
}
[18:03:12.043] Invocation finished in 47m59.512849561s with status SUCCEEDED