[16:04:34.408] New invocation is queued and will start shortly
[16:04:35.528] Starting the invocation (attempt 1)
[16:04:35.575] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:04:35.576] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:04:35.576] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9032242349017887280",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dfd71a819b11481d95a5304a05f1beb5ba984081\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9032242349017887280",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/dfd71a819b11481d95a5304a05f1beb5ba984081",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dfd71a819b11481d95a5304a05f1beb5ba984081",
"gitiles_ref:refs/heads/master"
]
}
[16:04:36.266] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602345875668281",
"id": "8866812287033285408",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dfd71a819b11481d95a5304a05f1beb5ba984081\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602345876151835",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176525",
"builder:Linux Builder (dbg)",
"buildset:commit/git/dfd71a819b11481d95a5304a05f1beb5ba984081",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dfd71a819b11481d95a5304a05f1beb5ba984081",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032242349017887280",
"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/8866812287033285408/+/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": "1602345876151997",
"url": "https://ci.chromium.org/b/8866812287033285408",
"utcnow_ts": "1602345876258215"
}
}
[16:04:36.266] Task URL: https://ci.chromium.org/b/8866812287033285408
[16:04:36.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:2:0) after 1m0s
[16:05:36.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:2:0)
[16:05:36.327] Timer tick, asking Buildbucket for the build status
[16:05:36.457] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:05:36.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:3:0) after 1m0s
[16:06:36.468] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:3:0)
[16:06:36.468] Timer tick, asking Buildbucket for the build status
[16:06:36.562] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:06:36.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:4:0) after 1m0s
[16:07:36.556] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:4:0)
[16:07:36.556] Timer tick, asking Buildbucket for the build status
[16:07:36.684] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:07:36.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:5:0) after 1m0s
[16:08:36.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:5:0)
[16:08:36.711] Timer tick, asking Buildbucket for the build status
[16:08:37.109] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:08:37.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:6:0) after 1m0s
[16:09:37.132] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:6:0)
[16:09:37.132] Timer tick, asking Buildbucket for the build status
[16:09:37.323] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:09:37.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:7:0) after 1m0s
[16:10:37.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:7:0)
[16:10:37.351] Timer tick, asking Buildbucket for the build status
[16:10:37.460] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:10:37.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:8:0) after 1m0s
[16:11:37.482] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:8:0)
[16:11:37.482] Timer tick, asking Buildbucket for the build status
[16:11:38.109] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:11:38.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:9:0) after 1m0s
[16:12:38.139] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:9:0)
[16:12:38.139] Timer tick, asking Buildbucket for the build status
[16:12:38.383] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:12:38.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:10:0) after 1m0s
[16:13:38.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:10:0)
[16:13:38.407] Timer tick, asking Buildbucket for the build status
[16:13:38.503] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:13:38.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:11:0) after 1m0s
[16:14:38.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:11:0)
[16:14:38.524] Timer tick, asking Buildbucket for the build status
[16:14:38.643] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:14:38.643] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:12:0) after 1m0s
[16:15:38.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:12:0)
[16:15:38.675] Timer tick, asking Buildbucket for the build status
[16:15:39.299] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:15:39.299] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:13:0) after 1m0s
[16:16:39.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:13:0)
[16:16:39.364] Timer tick, asking Buildbucket for the build status
[16:16:39.507] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:16:39.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:14:0) after 1m0s
[16:17:39.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:14:0)
[16:17:39.529] Timer tick, asking Buildbucket for the build status
[16:17:40.607] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:17:40.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:15:0) after 1m0s
[16:18:40.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:15:0)
[16:18:40.631] Timer tick, asking Buildbucket for the build status
[16:18:40.900] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:18:40.900] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:16:0) after 1m0s
[16:19:40.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:16:0)
[16:19:40.929] Timer tick, asking Buildbucket for the build status
[16:19:41.033] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:19:41.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:17:0) after 1m0s
[16:20:41.097] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:17:0)
[16:20:41.097] Timer tick, asking Buildbucket for the build status
[16:20:41.190] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:20:41.190] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:18:0) after 1m0s
[16:21:41.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:18:0)
[16:21:41.215] Timer tick, asking Buildbucket for the build status
[16:21:41.285] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:21:41.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:19:0) after 1m0s
[16:22:41.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:19:0)
[16:22:41.321] Timer tick, asking Buildbucket for the build status
[16:22:41.814] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:22:41.814] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:20:0) after 1m0s
[16:23:41.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:20:0)
[16:23:41.885] Timer tick, asking Buildbucket for the build status
[16:23:42.203] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:23:42.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:21:0) after 1m0s
[16:24:42.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:21:0)
[16:24:42.260] Timer tick, asking Buildbucket for the build status
[16:24:42.424] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:24:42.424] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:22:0) after 1m0s
[16:25:42.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:22:0)
[16:25:42.503] Timer tick, asking Buildbucket for the build status
[16:25:42.611] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:25:42.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:23:0) after 1m0s
[16:26:42.657] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:23:0)
[16:26:42.657] Timer tick, asking Buildbucket for the build status
[16:26:42.884] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:26:42.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:24:0) after 1m0s
[16:27:42.908] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:24:0)
[16:27:42.908] Timer tick, asking Buildbucket for the build status
[16:27:43.172] Build 8866812287033285408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:27:43.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:25:0) after 1m0s
[16:28:26.165] Received PubSub notification, asking Buildbucket for the build status
[16:28:26.416] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:43.310] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:25:0)
[16:28:43.310] Timer tick, asking Buildbucket for the build status
[16:28:45.284] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:45.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:27:0) after 1m0s
[16:29:45.336] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:27:0)
[16:29:45.336] Timer tick, asking Buildbucket for the build status
[16:29:45.770] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:45.770] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:28:0) after 1m0s
[16:30:45.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:28:0)
[16:30:45.835] Timer tick, asking Buildbucket for the build status
[16:30:46.016] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:46.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:29:0) after 1m0s
[16:31:46.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:29:0)
[16:31:46.137] Timer tick, asking Buildbucket for the build status
[16:31:46.203] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:46.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:30:0) after 1m0s
[16:32:46.282] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:30:0)
[16:32:46.282] Timer tick, asking Buildbucket for the build status
[16:32:46.614] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:46.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:31:0) after 1m0s
[16:33:46.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:31:0)
[16:33:46.658] Timer tick, asking Buildbucket for the build status
[16:33:46.779] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:46.779] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:32:0) after 1m0s
[16:34:46.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:32:0)
[16:34:46.954] Timer tick, asking Buildbucket for the build status
[16:34:47.055] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:47.055] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:33:0) after 1m0s
[16:35:47.119] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:33:0)
[16:35:47.119] Timer tick, asking Buildbucket for the build status
[16:35:47.519] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:47.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:34:0) after 1m0s
[16:36:47.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:34:0)
[16:36:47.545] Timer tick, asking Buildbucket for the build status
[16:36:47.604] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:47.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:35:0) after 1m0s
[16:37:47.625] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:35:0)
[16:37:47.625] Timer tick, asking Buildbucket for the build status
[16:37:47.743] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:47.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:36:0) after 1m0s
[16:38:47.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:36:0)
[16:38:47.766] Timer tick, asking Buildbucket for the build status
[16:38:47.836] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:47.837] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:37:0) after 1m0s
[16:39:47.908] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:37:0)
[16:39:47.908] Timer tick, asking Buildbucket for the build status
[16:39:48.026] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:48.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:38:0) after 1m0s
[16:40:48.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:38:0)
[16:40:48.066] Timer tick, asking Buildbucket for the build status
[16:40:48.319] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:48.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:39:0) after 1m0s
[16:41:48.467] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:39:0)
[16:41:48.467] Timer tick, asking Buildbucket for the build status
[16:41:48.539] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:48.539] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:40:0) after 1m0s
[16:42:48.563] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:40:0)
[16:42:48.563] Timer tick, asking Buildbucket for the build status
[16:42:48.941] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:48.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:41:0) after 1m0s
[16:43:48.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:41:0)
[16:43:48.938] Timer tick, asking Buildbucket for the build status
[16:43:48.998] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:48.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:42:0) after 1m0s
[16:44:49.198] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:42:0)
[16:44:49.198] Timer tick, asking Buildbucket for the build status
[16:44:49.399] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:49.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:43:0) after 1m0s
[16:45:49.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:43:0)
[16:45:49.552] Timer tick, asking Buildbucket for the build status
[16:45:49.868] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:49.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:44:0) after 1m0s
[16:46:49.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:44:0)
[16:46:49.864] Timer tick, asking Buildbucket for the build status
[16:46:50.009] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:50.009] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:45:0) after 1m0s
[16:47:50.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:45:0)
[16:47:50.032] Timer tick, asking Buildbucket for the build status
[16:47:50.280] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:50.280] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:46:0) after 1m0s
[16:48:50.466] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:46:0)
[16:48:50.466] Timer tick, asking Buildbucket for the build status
[16:48:50.643] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:50.643] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:47:0) after 1m0s
[16:49:50.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:47:0)
[16:49:50.868] Timer tick, asking Buildbucket for the build status
[16:49:51.124] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:51.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:48:0) after 1m0s
[16:50:51.155] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:48:0)
[16:50:51.155] Timer tick, asking Buildbucket for the build status
[16:50:51.316] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:51.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:49:0) after 1m0s
[16:51:51.469] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:49:0)
[16:51:51.469] Timer tick, asking Buildbucket for the build status
[16:51:51.531] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:51.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:50:0) after 1m0s
[16:52:51.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:50:0)
[16:52:51.923] Timer tick, asking Buildbucket for the build status
[16:52:51.997] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:51.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:51:0) after 1m0s
[16:53:52.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:51:0)
[16:53:52.103] Timer tick, asking Buildbucket for the build status
[16:53:52.215] Build 8866812287033285408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:52.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032242349017887280:52:0) after 1m0s
[16:54:19.763] Received PubSub notification, asking Buildbucket for the build status
[16:54:19.855] Build 8866812287033285408: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:54:19.855] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602348858999562",
"created_by": "project:chromium",
"created_ts": "1602345875668281",
"id": "8866812287033285408",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dfd71a819b11481d95a5304a05f1beb5ba984081\"}}",
"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\": \"dfd71a819b11481d95a5304a05f1beb5ba984081\", \"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-east1-d-8-65-cskg\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 176525, \"got_angle_revision\": \"b2ff69f856d98312bbfe14f80d084b7d8795281f\", \"got_dawn_revision\": \"1c25198384e7ecfebbd3ac84203d3b1d46a0e228\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"dfd71a819b11481d95a5304a05f1beb5ba984081\", \"got_revision_cp\": \"refs/heads/master@{#815951}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"139f5c351e1ff62e465526d4d2f40d3b08a27169\", \"got_v8_revision\": \"07b0b1dcde4a99294b8028d83f4ea244885cc091\", \"got_v8_revision_cp\": \"refs/heads/8.8.62@{#1}\", \"got_webrtc_revision\": \"3326535126e435f1ba647885ce43a8f0f3d317eb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32375}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dfd71a819b11481d95a5304a05f1beb5ba984081\", \"swarm_hashes_refs/heads/master(at){#815951}_without_patch\": {\"absl_hardening_tests\": \"b8d60173f0760bf3bee3b77a074e4d682bb1d76f\", \"accessibility_unittests\": \"2e0c92a6de4937be330513114f16f69be7a55f41\", \"app_shell_unittests\": \"dcfcc9badfe48ca8bfec9658e3ef4b16fc70a343\", \"aura_unittests\": \"33b54339a63058959435528ee76f460d05a1b1bf\", \"base_unittests\": \"b8d8a21d08a9cb858f58a1ac12bc343931de95fb\", \"base_util_unittests\": \"6b6592e956a6c1d9953dfb4ca0a9fd0e270bd34d\", \"blink_common_unittests\": \"9fcd367ac186e0f4463df2eec5df7c8fc33334b8\", \"blink_fuzzer_unittests\": \"4775a3461c6d45685f62b073e902f747e19bde8c\", \"blink_heap_unittests\": \"441241caa3dc6063af35b1799c085275eadce4a2\", \"blink_platform_unittests\": \"ee14aecfba0799967b50fded5d7d20236bcc4ada\", \"blink_python_tests\": \"3666206a70ab9d6ded58d6758e0d7de61777a4b9\", \"blink_unittests\": \"ece7e23e37f35faa22c71e455ccf530d806786e4\", \"blink_web_tests\": \"079c30d5d6b019d6f2799f5aad3de8230b0b77c0\", \"boringssl_crypto_tests\": \"09270dd556b15d027b6995c995bf98329979b041\", \"boringssl_ssl_tests\": \"dcf404aeb186c6d90cf3ff0992b756d2c75127a4\", \"browser_tests\": \"fbe1ba310170d8ca6408a81c577a49bd0bbbf4e6\", \"capture_unittests\": \"f843aade6b7579cfb638c6bf717fbc7b64cc839b\", \"cast_unittests\": \"25bc9908e21d962ddc4264d3584cd212a39a8bfb\", \"cc_unittests\": \"285859aeb06c52e5b56cb40cba89e8ab57d6c63d\", \"chrome_app_unittests\": \"0258868b758ec75d07ad1884eea12993897ea25c\", \"chromedriver_unittests\": \"e9f38ca3cd7d2d1c1579e0bfafe778f9fa397b1f\", \"components_browsertests\": \"28c3818544403e3acc537c0d074afac223726f3d\", \"components_unittests\": \"66d0abfbe905559daa21c2170f71637867c836d6\", \"compositor_unittests\": \"8eb7ea789d9b33c371e5be6ff9550b6b2f54ee7b\", \"content_browsertests\": \"564eba894a9a8b329ea8f0bc3c6c0cb7f6aa7483\", \"content_shell_crash_test\": \"6bb8006944c52a88cd2c903b10df21e6134c36a0\", \"content_unittests\": \"de1906ad9ce24d9db2852a3394cb80c8f3814142\", \"crashpad_tests\": \"750cf1b44011d7dcecbfc780ba1c2b3660e95b18\", \"cronet_tests\": \"e942ef0c7a77b47570971b67eaf50597eedbeb40\", \"cronet_unittests\": \"230149e9bbf3a4721c922ab8bbde2720b0c59ffe\", \"crypto_unittests\": \"652a79d6ae19ecdf20167d322b07eccc3d5dca57\", \"dbus_unittests\": \"802a4b5014b9ed8ce7c89034d269088ed87e65eb\", \"device_unittests\": \"7277222625bab8c5c2ef23d7d2fcb3ad14a9575c\", \"display_unittests\": \"23ee6656750dd8d20c059def39ff9c64b5720000\", \"events_unittests\": \"2845bd47a57dabdb16dce8f69c9b3dfd1dc58a5b\", \"extension_docserver_python_unittests\": \"51937a638141a4c7fa80886975ce06994f854c94\", \"extensions_browsertests\": \"28c2d80afce4e41893e79c96a14b272986dd3107\", \"extensions_unittests\": \"fbcb2ae31d7ab239f0354cd959d3d02854f7543a\", \"filesystem_service_unittests\": \"465c7ee55b0ee85bf25d25c6f71688e22f5eb68d\", \"flatbuffers_unittests\": \"7c821f13730963d6e07deae074f4fffab315d766\", \"gcm_unit_tests\": \"63b317cb00673232a18462e1b1d6ef0eb766fb1e\", \"gfx_unittests\": \"917d4d58ac452ce9c83d8a5df643845798019c84\", \"gin_unittests\": \"c288dd5cf8d829467d6b44236f2c86e4efba3c81\", \"google_apis_unittests\": \"f03a3bd2b2d22c4bc29410ff47eead1bcf1186c8\", \"gpu_unittests\": \"cfb0084d3ba77afc119ebca2cd801d8883119003\", \"grit_python_unittests\": \"55fa961d85005331568451ce869e032331bd4b90\", \"gwp_asan_unittests\": \"cc33839dff8e66bb1b951120d6a9eda08bf1f3fd\", \"headless_browsertests\": \"678e63fc27df1b7fd84817036eca435b173546c3\", \"headless_unittests\": \"e4164578c93dfc7fad276a1895d0836c88f89fb2\", \"interactive_ui_tests\": \"84033b69a0f71c43643ce583b99ec879829f5afd\", \"ipc_tests\": \"f978ef6083472819741eb4e2e4930b5c971cac55\", \"jingle_unittests\": \"289f689a05d6ee63c5bd15292778b7652f1f6832\", \"latency_unittests\": \"5f7bd69dc147283842c66bf598af32a2a2ca4cbb\", \"libjingle_xmpp_unittests\": \"bc7ca5663f8490fc2a345c104f25577c7057808f\", \"media_blink_unittests\": \"9397c67868e3265e63cec773a5f0397b447bc306\", \"media_unittests\": \"60047b83727ea15868f0d6327807bc73b008c352\", \"message_center_unittests\": \"52b540287f05c1c2166094a05f8883a3d4969452\", \"metrics_python_tests\": \"c843fe2dceeea774ea978f3637eb7cd5a56f53e4\", \"midi_unittests\": \"d481f088a2f455e57ba55f8485d584f53ce78b8f\", \"mojo_core_unittests\": \"75e882eb6a262235c735ec53ed9c68706dcf5181\", \"mojo_unittests\": \"c02838101e4b01f1d3881a66a7d047804da3bff2\", \"nacl_helper_nonsfi_unittests\": \"11559e5b3712c42d38b5862396e916b4f2b82689\", \"nacl_loader_unittests\": \"842e3ad2cdf74b736dbc54b529624c9d7b0bdea1\", \"native_theme_unittests\": \"393ce0f0496b5fcfd3104d651a13a71bf5eab923\", \"net_unittests\": \"5c8dcdc1c24b83c5d26f008e16eb7e2c52130a5c\", \"openscreen_unittests\": \"d632793bb08c2a60290e885683cf7e7f9a8ad51f\", \"pdf_unittests\": \"58fd082045fd660901698585532c39bf8cdaef2a\", \"perfetto_unittests\": \"a05d318dc60714a8f966afa10a14edab395bece2\", \"ppapi_unittests\": \"b98ebe896dafdfb67de28e4a4ab474542120940f\", \"printing_unittests\": \"e14321f01d64118be80f438e26d2627e0a79547c\", \"remoting_unittests\": \"a83bfe052e4eb1c886032e257c0bf228882e4295\", \"sandbox_linux_unittests\": \"235904c14865878d62c68571e3473958aea9f4fd\", \"service_manager_unittests\": \"18267fae39f061823ef26a42e91271ca1a370cb2\", \"services_unittests\": \"95523a71d6a7f043505482b3255c1159110eb47f\", \"shell_dialogs_unittests\": \"215cdbc2ea079852c1e299d9584dd313625b2e88\", \"skia_unittests\": \"3d04337b08168a7c7325d640ff1ede7100236ab4\", \"snapshot_unittests\": \"3f7cb8e3eae13d34ed2a966c08a2d97f5390a040\", \"sql_unittests\": \"f6a58b42c1c161ce1ebdd74e89f5475acc065ac7\", \"standalone_angle_unittests\": \"f0ec8f84b236d03e870abd3187f973a66b546115\", \"storage_unittests\": \"bd8928b01f8723e9839bf340bfb25deb0e50c9c3\", \"sync_integration_tests\": \"1af200f99c0c67f1d8541642ecfd6575c435977b\", \"telemetry_gpu_unittests\": \"0e929c7e04ed190d699a010103b07c84f4df0a6d\", \"telemetry_perf_unittests\": \"555d71dfa931fd09f3b6bfe7b533b1f4c243c6ed\", \"telemetry_unittests\": \"b2a1db10b1d0d6278cf636e65b3f4f729c14fc79\", \"traffic_annotation_auditor_unittests\": \"1d8521d47ab8d215d9ac67e2264c14fe3f62c7e6\", \"ui_base_unittests\": \"390a61d53e3194acb31e0af84d9195876a041c3e\", \"ui_touch_selection_unittests\": \"63b432c18b5e988438cbfd85e3e3c8433220c35c\", \"unit_tests\": \"a367ba3702aef0c21279e48c93ff3030cd4845db\", \"url_unittests\": \"72820316c9aee193199517460be5824b8fc29178\", \"views_perftests\": \"d8fd6f1b306d3254fd0fc76f968ca6a2e852de26\", \"views_unittests\": \"e469eeb11dcbcf9a12944d29845f2cd0d8f3e1bd\", \"viz_unittests\": \"5be8d63c123b5b875260190bd64228f5dfd012b2\", \"vr_common_unittests\": \"ab53d616ead79f81acbbed8c1a41a28d9d9dffd1\", \"vr_pixeltests\": \"03cf0fc6ca0e742d1c7dd407019fbe82c6662981\", \"webdriver_wpt_tests\": \"eda78c99c9babed4e1f486e817281706d536d0de\", \"weblayer_browsertests\": \"ea7ce46f0834edd21d3de9cf54242c03e0ff2d11\", \"weblayer_unittests\": \"5a061160abec582411f5477a91faa9665a991fc7\", \"wm_unittests\": \"842be22767efb25c641fb6c2ff35b8f37d809172\", \"wtf_unittests\": \"b85d42a82dd6193e5de2e1504e311da62d733665\", \"x11_unittests\": \"fe90f3d44a15d91b5f2a1348694ab0c4b065f74a\", \"xr_browser_tests\": \"4af229f3f8702ec6938e128181bed2b5306ff6fd\", \"zlib_unittests\": \"e310be640379954da6a17c2cb7bef89ad2dffd1b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_b273538f870349aebb83faf56bcfccf87dc35b17d3d52dccf63adc8ba25ae3cc_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_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-east1-d-8-65-cskg\"], \"image\": [\"chrome-xenial-20100700-ace2c028da3\"], \"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\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602347304854594",
"status": "COMPLETED",
"status_changed_ts": "1602348859506152",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176525",
"builder:Linux Builder (dbg)",
"buildset:commit/git/dfd71a819b11481d95a5304a05f1beb5ba984081",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dfd71a819b11481d95a5304a05f1beb5ba984081",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032242349017887280",
"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/8866812287033285408/+/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:4f2c134550e19210",
"user_agent:luci-scheduler"
],
"updated_ts": "1602348859511580",
"url": "https://ci.chromium.org/b/8866812287033285408",
"utcnow_ts": "1602348859845315"
}
}
[16:54:19.855] Invocation finished in 49m45.462961452s with status SUCCEEDED