[16:28:06.581] New invocation is queued and will start shortly
[16:28:07.644] Starting the invocation (attempt 1)
[16:28:07.691] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:28:07.692] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:28:07.692] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028073407796308224",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"749008456c299bed0d0e01a5f8a186ec3dc85f44\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9028073407796308224",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/749008456c299bed0d0e01a5f8a186ec3dc85f44",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/749008456c299bed0d0e01a5f8a186ec3dc85f44",
"gitiles_ref:refs/heads/master"
]
}
[16:28:08.663] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606321687799365",
"id": "8862643345853103648",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"749008456c299bed0d0e01a5f8a186ec3dc85f44\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606321688444957",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178032",
"builder:Linux Builder (dbg)",
"buildset:commit/git/749008456c299bed0d0e01a5f8a186ec3dc85f44",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/749008456c299bed0d0e01a5f8a186ec3dc85f44",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028073407796308224",
"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/8862643345853103648/+/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": "1606321688445171",
"url": "https://ci.chromium.org/b/8862643345853103648",
"utcnow_ts": "1606321688652806"
}
}
[16:28:08.663] Task URL: https://ci.chromium.org/b/8862643345853103648
[16:28:08.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:2:0) after 1m0s
[16:28:10.776] Received PubSub notification, asking Buildbucket for the build status
[16:28:10.835] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:08.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:2:0)
[16:29:08.743] Timer tick, asking Buildbucket for the build status
[16:29:09.210] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:09.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:4:0) after 1m0s
[16:30:09.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:4:0)
[16:30:09.393] Timer tick, asking Buildbucket for the build status
[16:30:09.675] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:09.675] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:5:0) after 1m0s
[16:31:10.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:5:0)
[16:31:10.008] Timer tick, asking Buildbucket for the build status
[16:31:10.259] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:10.259] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:6:0) after 1m0s
[16:32:10.734] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:6:0)
[16:32:10.734] Timer tick, asking Buildbucket for the build status
[16:32:10.854] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:10.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:7:0) after 1m0s
[16:33:10.965] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:7:0)
[16:33:10.965] Timer tick, asking Buildbucket for the build status
[16:33:11.669] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:11.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:8:0) after 1m0s
[16:34:11.754] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:8:0)
[16:34:11.754] Timer tick, asking Buildbucket for the build status
[16:34:11.879] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:11.879] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:9:0) after 1m0s
[16:35:11.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:9:0)
[16:35:11.939] Timer tick, asking Buildbucket for the build status
[16:35:12.296] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:12.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:10:0) after 1m0s
[16:36:12.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:10:0)
[16:36:12.437] Timer tick, asking Buildbucket for the build status
[16:36:12.569] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:12.569] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:11:0) after 1m0s
[16:37:12.634] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:11:0)
[16:37:12.634] Timer tick, asking Buildbucket for the build status
[16:37:12.723] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:12.723] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:12:0) after 1m0s
[16:38:12.902] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:12:0)
[16:38:12.902] Timer tick, asking Buildbucket for the build status
[16:38:13.075] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:13.075] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:13:0) after 1m0s
[16:39:13.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:13:0)
[16:39:13.105] Timer tick, asking Buildbucket for the build status
[16:39:13.169] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:13.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:14:0) after 1m0s
[16:40:13.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:14:0)
[16:40:13.323] Timer tick, asking Buildbucket for the build status
[16:40:13.401] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:13.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:15:0) after 1m0s
[16:41:13.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:15:0)
[16:41:13.536] Timer tick, asking Buildbucket for the build status
[16:41:13.769] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:13.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:16:0) after 1m0s
[16:42:13.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:16:0)
[16:42:13.915] Timer tick, asking Buildbucket for the build status
[16:42:14.077] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:14.077] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:17:0) after 1m0s
[16:43:14.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:17:0)
[16:43:14.142] Timer tick, asking Buildbucket for the build status
[16:43:14.242] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:14.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:18:0) after 1m0s
[16:44:14.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:18:0)
[16:44:14.424] Timer tick, asking Buildbucket for the build status
[16:44:14.525] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:14.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:19:0) after 1m0s
[16:45:14.557] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:19:0)
[16:45:14.557] Timer tick, asking Buildbucket for the build status
[16:45:14.648] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:14.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:20:0) after 1m0s
[16:46:14.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:20:0)
[16:46:14.695] Timer tick, asking Buildbucket for the build status
[16:46:14.906] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:14.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:21:0) after 1m0s
[16:47:14.983] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:21:0)
[16:47:14.983] Timer tick, asking Buildbucket for the build status
[16:47:15.063] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:15.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:22:0) after 1m0s
[16:48:15.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:22:0)
[16:48:15.085] Timer tick, asking Buildbucket for the build status
[16:48:15.191] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:15.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:23:0) after 1m0s
[16:49:15.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:23:0)
[16:49:15.205] Timer tick, asking Buildbucket for the build status
[16:49:15.260] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:15.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:24:0) after 1m0s
[16:50:15.250] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:24:0)
[16:50:15.250] Timer tick, asking Buildbucket for the build status
[16:50:15.428] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:15.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:25:0) after 1m0s
[16:51:15.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:25:0)
[16:51:15.484] Timer tick, asking Buildbucket for the build status
[16:51:16.149] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:16.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:26:0) after 1m0s
[16:52:16.145] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:26:0)
[16:52:16.145] Timer tick, asking Buildbucket for the build status
[16:52:17.604] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:17.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:27:0) after 1m0s
[16:53:17.656] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:27:0)
[16:53:17.656] Timer tick, asking Buildbucket for the build status
[16:53:17.757] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:17.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:28:0) after 1m0s
[16:54:17.867] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:28:0)
[16:54:17.867] Timer tick, asking Buildbucket for the build status
[16:54:17.943] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:17.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:29:0) after 1m0s
[16:55:17.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:29:0)
[16:55:17.955] Timer tick, asking Buildbucket for the build status
[16:55:18.614] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:18.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:30:0) after 1m0s
[16:56:18.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:30:0)
[16:56:18.664] Timer tick, asking Buildbucket for the build status
[16:56:18.749] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:18.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:31:0) after 1m0s
[16:57:18.783] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:31:0)
[16:57:18.783] Timer tick, asking Buildbucket for the build status
[16:57:19.650] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:19.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:32:0) after 1m0s
[16:58:19.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:32:0)
[16:58:19.706] Timer tick, asking Buildbucket for the build status
[16:58:19.820] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:19.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:33:0) after 1m0s
[16:59:19.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:33:0)
[16:59:19.847] Timer tick, asking Buildbucket for the build status
[16:59:19.908] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:19.908] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:34:0) after 1m0s
[17:00:19.956] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:34:0)
[17:00:19.956] Timer tick, asking Buildbucket for the build status
[17:00:20.060] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:20.060] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:35:0) after 1m0s
[17:01:20.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:35:0)
[17:01:20.177] Timer tick, asking Buildbucket for the build status
[17:01:20.255] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:20.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:36:0) after 1m0s
[17:02:20.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:36:0)
[17:02:20.289] Timer tick, asking Buildbucket for the build status
[17:02:20.399] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:20.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:37:0) after 1m0s
[17:03:20.413] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:37:0)
[17:03:20.413] Timer tick, asking Buildbucket for the build status
[17:03:20.519] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:20.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:38:0) after 1m0s
[17:04:20.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:38:0)
[17:04:20.545] Timer tick, asking Buildbucket for the build status
[17:04:20.740] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:20.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:39:0) after 1m0s
[17:05:20.725] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:39:0)
[17:05:20.725] Timer tick, asking Buildbucket for the build status
[17:05:20.802] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:20.802] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:40:0) after 1m0s
[17:06:20.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:40:0)
[17:06:20.871] Timer tick, asking Buildbucket for the build status
[17:06:20.998] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:20.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:41:0) after 1m0s
[17:07:21.022] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:41:0)
[17:07:21.022] Timer tick, asking Buildbucket for the build status
[17:07:21.086] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:21.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:42:0) after 1m0s
[17:08:21.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:42:0)
[17:08:21.116] Timer tick, asking Buildbucket for the build status
[17:08:21.625] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:21.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:43:0) after 1m0s
[17:09:21.737] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:43:0)
[17:09:21.737] Timer tick, asking Buildbucket for the build status
[17:09:22.533] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:22.533] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:44:0) after 1m0s
[17:10:22.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:44:0)
[17:10:22.591] Timer tick, asking Buildbucket for the build status
[17:10:22.674] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:22.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:45:0) after 1m0s
[17:11:22.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:45:0)
[17:11:22.701] Timer tick, asking Buildbucket for the build status
[17:11:22.886] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:22.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:46:0) after 1m0s
[17:12:22.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:46:0)
[17:12:22.933] Timer tick, asking Buildbucket for the build status
[17:12:22.995] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:22.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:47:0) after 1m0s
[17:13:23.011] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:47:0)
[17:13:23.011] Timer tick, asking Buildbucket for the build status
[17:13:23.113] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:23.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:48:0) after 1m0s
[17:14:23.163] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:48:0)
[17:14:23.163] Timer tick, asking Buildbucket for the build status
[17:14:23.287] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:23.287] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:49:0) after 1m0s
[17:15:23.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:49:0)
[17:15:23.312] Timer tick, asking Buildbucket for the build status
[17:15:23.525] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:23.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:50:0) after 1m0s
[17:16:23.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:50:0)
[17:16:23.551] Timer tick, asking Buildbucket for the build status
[17:16:23.613] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:23.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:51:0) after 1m0s
[17:17:23.636] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:51:0)
[17:17:23.636] Timer tick, asking Buildbucket for the build status
[17:17:23.755] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:23.755] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:52:0) after 1m0s
[17:18:23.784] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:52:0)
[17:18:23.784] Timer tick, asking Buildbucket for the build status
[17:18:24.050] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:24.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:53:0) after 1m0s
[17:19:24.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:53:0)
[17:19:24.321] Timer tick, asking Buildbucket for the build status
[17:19:24.406] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:24.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:54:0) after 1m0s
[17:20:24.490] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:54:0)
[17:20:24.490] Timer tick, asking Buildbucket for the build status
[17:20:25.196] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:25.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:55:0) after 1m0s
[17:21:25.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:55:0)
[17:21:25.299] Timer tick, asking Buildbucket for the build status
[17:21:25.527] Build 8862643345853103648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:25.527] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028073407796308224:56:0) after 1m0s
[17:22:02.937] Received PubSub notification, asking Buildbucket for the build status
[17:22:03.040] Build 8862643345853103648: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:22:03.040] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606324919046462",
"created_by": "project:chromium",
"created_ts": "1606321687799365",
"id": "8862643345853103648",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"749008456c299bed0d0e01a5f8a186ec3dc85f44\"}}",
"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\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"749008456c299bed0d0e01a5f8a186ec3dc85f44\", \"project\": \"chromium/src\"}], \"$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-100-ksf5\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178032, \"got_angle_revision\": \"bb4f496d2a32aa2c872f1d998c6d12e738e72a65\", \"got_dawn_revision\": \"a66263753a9f31ae9fa05af4f5ef0b18924d0b8e\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"749008456c299bed0d0e01a5f8a186ec3dc85f44\", \"got_revision_cp\": \"refs/heads/master@{#831029}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"43bb60e1fa119d80b449c6550dd2b72328b101b9\", \"got_v8_revision\": \"c38503fc1652232c4e2f897daf4501b9d98db210\", \"got_v8_revision_cp\": \"refs/heads/8.9.47@{#1}\", \"got_webrtc_revision\": \"9db3ab201ec73d5bbc547ebe2701b4695d1e281f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32690}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"749008456c299bed0d0e01a5f8a186ec3dc85f44\", \"swarm_hashes_refs/heads/master(at){#831029}_without_patch\": {\"absl_hardening_tests\": \"47302d8f7075c7918aacf6a3749f3e9f0a69241b\", \"accessibility_unittests\": \"4d487928faf56df0c9283a3acc4631e56720da2b\", \"angle_unittests\": \"3bc646558b6f603816ce9e41838abd69bf4517a0\", \"app_shell_unittests\": \"f93fa8f40d9abe7fb386683b1a9b32aa75652357\", \"aura_unittests\": \"d23ea686170ea7849a82b2c1333681d3a0914893\", \"base_unittests\": \"44ddedcd902c4b22d1362362e03aee5d3ab15ce8\", \"base_util_unittests\": \"5149cc7b919fe314e994a5f568539fca26076fba\", \"blink_common_unittests\": \"dafad2b32a47dea23d40301b0a6709df3a3bf184\", \"blink_fuzzer_unittests\": \"3802fd168f0de500a515f116b36f55d300701253\", \"blink_heap_unittests\": \"49f36b7e3b68cb2bf8d199fddacdd3a8c51ac5ae\", \"blink_platform_unittests\": \"329447f014e355b428eff7b031063b48fed52399\", \"blink_python_tests\": \"02ea43e6fa2b08debe7ef4a29470fbd5c10d7513\", \"blink_unittests\": \"ec1045cde6d3f144561dd7da7c9961f29454d7e2\", \"blink_web_tests\": \"6d23d25b1551a7d76cf63641aad4715413fafb41\", \"boringssl_crypto_tests\": \"a53aa367c0d367fd0b5b7567bf62c9b0cdcd1de6\", \"boringssl_ssl_tests\": \"f3d183baa3ef666e5de45e12a1bb5f0584c44c22\", \"browser_tests\": \"8a9cd075e227d915cc091a9fb3ee110a9a122ca1\", \"capture_unittests\": \"112be4291348f670c3e5150b96f19b753a5ae1f1\", \"cast_unittests\": \"d14715a0d6e62d18d74f133ad5b120800a09f684\", \"cc_unittests\": \"f28fdf4565dd149b93e33a7fea28b446f7814aa8\", \"chrome_app_unittests\": \"b93d68db8040b7373313d11af8d7ef0ab22ea67d\", \"chromedriver_unittests\": \"050b3715f739aaa4e2e5e25a875173fa394b8172\", \"components_browsertests\": \"eabbd7b54c8b659b64279188aad07c8457fe8835\", \"components_unittests\": \"f681320f7a5876571f287b9c778f7e239bd73f7b\", \"compositor_unittests\": \"8e40108e1d8210097ef8553a6fb6f61ba6ea4d46\", \"content_browsertests\": \"596397a249528e567de40f3004dd070b10e3c376\", \"content_shell_crash_test\": \"ba7f5774ec5181b37a46e02d3811fbf20c679687\", \"content_unittests\": \"af2c8298975e24ed59545a80e87182d0b69a4a3f\", \"crashpad_tests\": \"fbc1bcd8a42b033694580fbe3c16047ecf772d97\", \"cronet_tests\": \"54670248e6781195c2d0c50f87c367fd0ad24a3e\", \"cronet_unittests\": \"6d3a590c072db421266eb7d261f2291dfa02ce49\", \"crypto_unittests\": \"da4bbc31af49c3d9a3fd16f59dcf6281f230370d\", \"dbus_unittests\": \"77e39c2bea63a57c326ad72a2aa24d490f4c575f\", \"device_unittests\": \"351b2d3518bd2b398a140c995a1fb7e5676e40f8\", \"display_unittests\": \"3f4f3e535b4f864d8b9237c89368f4beb2396549\", \"events_unittests\": \"ca5cebb4c2e0c1f0a74d72c7529c2bd9f74e39d2\", \"extension_docserver_python_unittests\": \"342ce2267bfdb6b6b9359438e03e29931da2f40c\", \"extensions_browsertests\": \"25fdc92114aacc2765434d701efecd336b099958\", \"extensions_unittests\": \"d8c487f7665f343851fd0a2964428f99f820afa7\", \"filesystem_service_unittests\": \"4f3f55204b7cc041fc4a650523a713ed0cba0e68\", \"flatbuffers_unittests\": \"dd6267ccaa5ef4f5de95507aa468128ed4c0a477\", \"gcm_unit_tests\": \"71a4e3c40a1eda4965f4beceb59a48269fede1d9\", \"gfx_unittests\": \"5337f28a181863ebf8cd1d492d2872da7b45d6ab\", \"gin_unittests\": \"235e8676040a5df7c25520c33ea31986bca62aae\", \"google_apis_unittests\": \"61a249a682972d62f5cb8a4cac2afe22de90eefd\", \"gpu_unittests\": \"7673fed0eab0ffc13bc08893773398e4edb236cf\", \"grit_python_unittests\": \"4c94b719017789cff08aadfcad36defefc62c3b6\", \"gwp_asan_unittests\": \"bb85736671c017d22b3ed957258dc26c36252b23\", \"headless_browsertests\": \"f7afc1c587a27c02cdaadc76202ebd9c8b3c7b7b\", \"headless_unittests\": \"7f95576b5f3b2628964d2045d86c914f17cb3368\", \"interactive_ui_tests\": \"ebac950e3c542d2e3b5c28b742c39d2c120907d7\", \"ipc_tests\": \"e6b7113a2be1b0d038e0d77a3eb2f5c865bdd416\", \"jingle_unittests\": \"8abc9b1d0bc473f3eaf88f6e40a10d07627f8046\", \"latency_unittests\": \"03babfd9410d5cc6336eeba92fa676a1e09dfbfb\", \"libjingle_xmpp_unittests\": \"f834be1bd728869f15738d7b9fa92d662042fb28\", \"liburlpattern_unittests\": \"2e87dacd987287d94c863d3798793a77c3f663ef\", \"media_blink_unittests\": \"484e8fddb27a80ad79523bb1e2f2a93f69bb1284\", \"media_unittests\": \"5fb0d8aba60513a34b5a6f3173aad8b2323d60e8\", \"message_center_unittests\": \"40aef02001360027033ae17f2d17845bd719dae6\", \"metrics_python_tests\": \"0c98874c57545df90a09345eef4dd9512788a397\", \"midi_unittests\": \"3182c2546632b2528e584df290a98d4ace669c35\", \"mojo_core_unittests\": \"2e732171779a7c5188eab22468271ef7a28bf2a3\", \"mojo_unittests\": \"9aa8986e782423725f09469088294f57e4624668\", \"nacl_helper_nonsfi_unittests\": \"5b57acae98a1465cb1d513e1a2a6fb02b89042c9\", \"nacl_loader_unittests\": \"90522674e769e5c04f51290b10538978f805e207\", \"native_theme_unittests\": \"2cc40a00ffc62d91f418b635c103e6041d586303\", \"net_unittests\": \"12c9a2bdea1d457fed2bce8b1cbc491b59400f23\", \"openscreen_unittests\": \"4bfd800cb02ddc505f0c0bb85e3b8e6dc3cfb61a\", \"pdf_unittests\": \"3a31342997498f9007ec41825efb7033d34cc725\", \"perfetto_unittests\": \"e9c2b2e215fd3fb05ade8d2a36e6c2173d74fa8e\", \"ppapi_unittests\": \"106da9766b3c156414bab90c4f757d763935836b\", \"printing_unittests\": \"b92ca7065b14a58971091a60d651d233f32ad0fd\", \"remoting_unittests\": \"e46c2a560e2ff28469b4502e90eebbb4e76786d2\", \"sandbox_linux_unittests\": \"7d9281a98f653e7f9eff7fc16e298c5f62b08cb1\", \"service_manager_unittests\": \"8a266a3d08872a75e8b7fe8511b439b9b54450d7\", \"services_unittests\": \"7442490a3cd5a255f0656bf5f8d8890a0cf94d6b\", \"shell_dialogs_unittests\": \"dce559dc24ba04122df6cdd28f1ec9f61013ecf1\", \"skia_unittests\": \"c91adb90ccf475985a082f945cfe635bb3a31947\", \"snapshot_unittests\": \"1da658e3f7b6ec90ed16c29b54dbcdd5e40e53e0\", \"sql_unittests\": \"92951931364595e59c977f0ad3afd1b75ca298e5\", \"storage_unittests\": \"4dfaed5593bc4a03c848307b4cb0d57a42a3a32d\", \"sync_integration_tests\": \"ef80c15e22214b44591f9e3cf2d444ee651fb6d7\", \"telemetry_gpu_unittests\": \"6ae6a1c1d8eb41cb391e6873af46757277d6cee1\", \"telemetry_perf_unittests\": \"752ba563b8828988397bbf5fa2b044f9b398609a\", \"telemetry_unittests\": \"209724e43291ac58fc57b265e803743e0c465cd7\", \"traffic_annotation_auditor_unittests\": \"46de315b60ad947df0735b4c8db5ca06ba53e914\", \"ui_base_unittests\": \"6e59c03382783c018c469175c162919827c652d7\", \"ui_touch_selection_unittests\": \"0f900bf639ed32e9fd8e7d7a060df44bc5e141ca\", \"unit_tests\": \"714499e1ae32a26ab16d44b20619bd20bd06de69\", \"url_unittests\": \"4b61ac7edb65523dd3d366762bfdd145980e020f\", \"views_perftests\": \"735fdc437624dab14de8fdcdf16ba27f433cd0d7\", \"views_unittests\": \"9450109ef17129c3913f40755dddb0eae743e50c\", \"viz_unittests\": \"30b9d5ba2fe52851adb50c391a49935101857e40\", \"vr_common_unittests\": \"7546d98fcccebdc3d65657db4174545d77e4cb45\", \"vr_pixeltests\": \"20b6de8ceb6fd46d18ee7952ec44f2e7885965ff\", \"webdriver_wpt_tests\": \"ad668494209f19bb09ade49f0127ae8a15955118\", \"weblayer_browsertests\": \"7da6d321bd70f0da99a0e36e08226e523ec84c25\", \"weblayer_unittests\": \"f0c7effd26a7660fce425ee0e0e00f13598493be\", \"wm_unittests\": \"3cdc0de10ecc7c29f2a4f18cce3ee1f71f61a1aa\", \"wtf_unittests\": \"3e25d06d73d0cb4bc57c86607306da41e61748ee\", \"x11_unittests\": \"8524a90f6a9539d111fe00a9392b1b542d6ca932\", \"xr_browser_tests\": \"4cfa0d24395ad0bdddc93fd18910a55b6d38f3ce\", \"zlib_unittests\": \"f61b7f7f80d53935e1fd502752401f18b89ccb1d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_8e35dc9d0a811a7a5937b2845f7d6ff611dfc73c6ea10d73e1df62dc95746f2a_v2\", \"builder_9b8e7cf0a756f5448fe63e5ba03689dec6fdccd23b3dfddd2910706476b68383_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-100-ksf5\"], \"image\": [\"chrome-xenial-20111600-a937a23cefb\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606321690043134",
"status": "COMPLETED",
"status_changed_ts": "1606324920708205",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178032",
"builder:Linux Builder (dbg)",
"buildset:commit/git/749008456c299bed0d0e01a5f8a186ec3dc85f44",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/749008456c299bed0d0e01a5f8a186ec3dc85f44",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028073407796308224",
"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/8862643345853103648/+/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:50190d58b335e710",
"user_agent:luci-scheduler"
],
"updated_ts": "1606324920920334",
"url": "https://ci.chromium.org/b/8862643345853103648",
"utcnow_ts": "1606324923025897"
}
}
[17:22:03.040] Invocation finished in 53m56.477600482s with status SUCCEEDED