[11:12:44.485] New invocation is queued and will start shortly
[11:12:45.540] Starting the invocation (attempt 1)
[11:12:45.580] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:12:45.581] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:12:45.581] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028908621748864208",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9f22bfb49fe34720c34528ed56f5e8236d094d9c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9028908621748864208",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/9f22bfb49fe34720c34528ed56f5e8236d094d9c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9f22bfb49fe34720c34528ed56f5e8236d094d9c",
"gitiles_ref:refs/heads/master"
]
}
[11:12:47.042] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605525166421873",
"id": "8863478559053308864",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9f22bfb49fe34720c34528ed56f5e8236d094d9c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605525166924409",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/24843",
"builder:Linux Viz",
"buildset:commit/git/9f22bfb49fe34720c34528ed56f5e8236d094d9c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9f22bfb49fe34720c34528ed56f5e8236d094d9c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028908621748864208",
"scheduler_job_id:chromium/Linux Viz",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8863478559053308864/+/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": "1605525166924565",
"url": "https://ci.chromium.org/b/8863478559053308864",
"utcnow_ts": "1605525167031837"
}
}
[11:12:47.042] Task URL: https://ci.chromium.org/b/8863478559053308864
[11:12:47.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:2:0) after 1m0s
[11:12:51.042] Received PubSub notification, asking Buildbucket for the build status
[11:12:51.274] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:47.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:2:0)
[11:13:47.056] Timer tick, asking Buildbucket for the build status
[11:13:47.166] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:47.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:4:0) after 1m0s
[11:14:47.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:4:0)
[11:14:47.192] Timer tick, asking Buildbucket for the build status
[11:14:47.372] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:47.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:5:0) after 1m0s
[11:15:47.491] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:5:0)
[11:15:47.491] Timer tick, asking Buildbucket for the build status
[11:15:47.598] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:47.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:6:0) after 1m0s
[11:16:47.643] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:6:0)
[11:16:47.643] Timer tick, asking Buildbucket for the build status
[11:16:47.768] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:47.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:7:0) after 1m0s
[11:17:47.881] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:7:0)
[11:17:47.881] Timer tick, asking Buildbucket for the build status
[11:17:47.983] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:47.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:8:0) after 1m0s
[11:18:48.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:8:0)
[11:18:48.281] Timer tick, asking Buildbucket for the build status
[11:18:48.375] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:48.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:9:0) after 1m0s
[11:19:48.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:9:0)
[11:19:48.442] Timer tick, asking Buildbucket for the build status
[11:19:48.499] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:48.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:10:0) after 1m0s
[11:20:48.570] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:10:0)
[11:20:48.570] Timer tick, asking Buildbucket for the build status
[11:20:48.740] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:48.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:11:0) after 1m0s
[11:21:48.794] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:11:0)
[11:21:48.794] Timer tick, asking Buildbucket for the build status
[11:21:48.984] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:48.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:12:0) after 1m0s
[11:22:49.123] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:12:0)
[11:22:49.123] Timer tick, asking Buildbucket for the build status
[11:22:49.421] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:49.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:13:0) after 1m0s
[11:23:49.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:13:0)
[11:23:49.492] Timer tick, asking Buildbucket for the build status
[11:23:49.561] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:49.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:14:0) after 1m0s
[11:24:49.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:14:0)
[11:24:49.628] Timer tick, asking Buildbucket for the build status
[11:24:49.688] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:49.688] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:15:0) after 1m0s
[11:25:49.828] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:15:0)
[11:25:49.828] Timer tick, asking Buildbucket for the build status
[11:25:49.896] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:49.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:16:0) after 1m0s
[11:26:49.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:16:0)
[11:26:49.948] Timer tick, asking Buildbucket for the build status
[11:26:50.003] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:50.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:17:0) after 1m0s
[11:27:50.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:17:0)
[11:27:50.095] Timer tick, asking Buildbucket for the build status
[11:27:50.199] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:50.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:18:0) after 1m0s
[11:28:50.303] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:18:0)
[11:28:50.303] Timer tick, asking Buildbucket for the build status
[11:28:50.371] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:50.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:19:0) after 1m0s
[11:29:50.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:19:0)
[11:29:50.418] Timer tick, asking Buildbucket for the build status
[11:29:50.483] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:50.483] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:20:0) after 1m0s
[11:30:50.614] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:20:0)
[11:30:50.614] Timer tick, asking Buildbucket for the build status
[11:30:50.725] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:50.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:21:0) after 1m0s
[11:31:50.760] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:21:0)
[11:31:50.760] Timer tick, asking Buildbucket for the build status
[11:31:50.937] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:50.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:22:0) after 1m0s
[11:32:51.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:22:0)
[11:32:51.192] Timer tick, asking Buildbucket for the build status
[11:32:51.299] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:51.299] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:23:0) after 1m0s
[11:33:51.471] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:23:0)
[11:33:51.471] Timer tick, asking Buildbucket for the build status
[11:33:51.545] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:51.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:24:0) after 1m0s
[11:34:51.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:24:0)
[11:34:51.675] Timer tick, asking Buildbucket for the build status
[11:34:52.154] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:52.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:25:0) after 1m0s
[11:35:52.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:25:0)
[11:35:52.293] Timer tick, asking Buildbucket for the build status
[11:35:52.416] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:52.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:26:0) after 1m0s
[11:36:52.592] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:26:0)
[11:36:52.592] Timer tick, asking Buildbucket for the build status
[11:36:52.992] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:52.992] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:27:0) after 1m0s
[11:37:53.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:27:0)
[11:37:53.221] Timer tick, asking Buildbucket for the build status
[11:37:53.743] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:53.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:28:0) after 1m0s
[11:38:53.789] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:28:0)
[11:38:53.789] Timer tick, asking Buildbucket for the build status
[11:38:53.850] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:53.850] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:29:0) after 1m0s
[11:39:53.966] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:29:0)
[11:39:53.966] Timer tick, asking Buildbucket for the build status
[11:39:54.037] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:54.037] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:30:0) after 1m0s
[11:40:54.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:30:0)
[11:40:54.127] Timer tick, asking Buildbucket for the build status
[11:40:54.204] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:54.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:31:0) after 1m0s
[11:41:54.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:31:0)
[11:41:54.269] Timer tick, asking Buildbucket for the build status
[11:41:54.389] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:54.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:32:0) after 1m0s
[11:42:54.572] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:32:0)
[11:42:54.572] Timer tick, asking Buildbucket for the build status
[11:42:54.873] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:54.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:33:0) after 1m0s
[11:43:54.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:33:0)
[11:43:54.931] Timer tick, asking Buildbucket for the build status
[11:43:55.005] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:55.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:34:0) after 1m0s
[11:44:55.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:34:0)
[11:44:55.117] Timer tick, asking Buildbucket for the build status
[11:44:55.283] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:55.283] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:35:0) after 1m0s
[11:45:55.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:35:0)
[11:45:55.357] Timer tick, asking Buildbucket for the build status
[11:45:55.432] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:55.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:36:0) after 1m0s
[11:46:55.571] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:36:0)
[11:46:55.571] Timer tick, asking Buildbucket for the build status
[11:46:55.676] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:55.676] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:37:0) after 1m0s
[11:47:55.892] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:37:0)
[11:47:55.892] Timer tick, asking Buildbucket for the build status
[11:47:55.995] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:55.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:38:0) after 1m0s
[11:48:56.093] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:38:0)
[11:48:56.093] Timer tick, asking Buildbucket for the build status
[11:48:56.254] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:56.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:39:0) after 1m0s
[11:49:56.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:39:0)
[11:49:56.344] Timer tick, asking Buildbucket for the build status
[11:49:56.411] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:56.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:40:0) after 1m0s
[11:50:56.443] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:40:0)
[11:50:56.443] Timer tick, asking Buildbucket for the build status
[11:50:56.523] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:56.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:41:0) after 1m0s
[11:51:56.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:41:0)
[11:51:56.659] Timer tick, asking Buildbucket for the build status
[11:51:56.788] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:56.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:42:0) after 1m0s
[11:52:56.773] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:42:0)
[11:52:56.773] Timer tick, asking Buildbucket for the build status
[11:52:57.402] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:57.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:43:0) after 1m0s
[11:53:57.413] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:43:0)
[11:53:57.413] Timer tick, asking Buildbucket for the build status
[11:53:57.524] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:57.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:44:0) after 1m0s
[11:54:57.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:44:0)
[11:54:57.631] Timer tick, asking Buildbucket for the build status
[11:54:57.775] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:57.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:45:0) after 1m0s
[11:55:57.769] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:45:0)
[11:55:57.769] Timer tick, asking Buildbucket for the build status
[11:55:57.825] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:57.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:46:0) after 1m0s
[11:56:57.858] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:46:0)
[11:56:57.858] Timer tick, asking Buildbucket for the build status
[11:56:57.933] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:57.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:47:0) after 1m0s
[11:57:57.989] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:47:0)
[11:57:57.989] Timer tick, asking Buildbucket for the build status
[11:57:58.193] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:58.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:48:0) after 1m0s
[11:58:58.251] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:48:0)
[11:58:58.251] Timer tick, asking Buildbucket for the build status
[11:58:58.501] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:58.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:49:0) after 1m0s
[11:59:58.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:49:0)
[11:59:58.575] Timer tick, asking Buildbucket for the build status
[11:59:58.970] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:58.970] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:50:0) after 1m0s
[12:00:59.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:50:0)
[12:00:59.039] Timer tick, asking Buildbucket for the build status
[12:00:59.524] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:59.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:51:0) after 1m0s
[12:01:59.562] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:51:0)
[12:01:59.562] Timer tick, asking Buildbucket for the build status
[12:01:59.694] Build 8863478559053308864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:59.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9028908621748864208:52:0) after 1m0s
[12:02:47.130] Received PubSub notification, asking Buildbucket for the build status
[12:02:47.228] Build 8863478559053308864: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:02:47.228] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605528158715589",
"created_by": "project:chromium",
"created_ts": "1605525166421873",
"id": "8863478559053308864",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9f22bfb49fe34720c34528ed56f5e8236d094d9c\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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\": \"9f22bfb49fe34720c34528ed56f5e8236d094d9c\", \"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-38-byke\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Linux Viz\", \"buildnumber\": 24843, \"got_angle_revision\": \"f46e6201b40bdee3e0b79d5d97660fc302fd76f5\", \"got_dawn_revision\": \"575729e8dd25e0ac4631c9739a82118ea3545c6b\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"9f22bfb49fe34720c34528ed56f5e8236d094d9c\", \"got_revision_cp\": \"refs/heads/master@{#827742}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e4c1a25cc6797a47043fc415c53b8edcd7b3e37e\", \"got_v8_revision\": \"2dbcdc105b963ee2501c82139eef7e0603977ff0\", \"got_v8_revision_cp\": \"refs/heads/8.8.278@{#1}\", \"got_webrtc_revision\": \"99df1af2aed6a8d10bc62dc348f63d6c084c1949\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32609}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-viz-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9f22bfb49fe34720c34528ed56f5e8236d094d9c\", \"swarm_hashes_refs/heads/master(at){#827742}_without_patch\": {\"blink_web_tests\": \"d71b934f2ec8b73f75f3b8c233e15fd06c393d9f\", \"browser_tests\": \"0a314cc06a3408385df37fa7f9e7b0fb0eff72af\", \"content_browsertests\": \"51eb86199463c06e9e82dca52b2786e7000f0052\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_5e40e9df3c25d6ec04b042625e64587de25b7cc9257c9b922c4342550ccccbb8_v2\", \"builder_609b54f795c46f6da98bce3e3c3edeb2c2e2d72c7759cc5040a86edccd734c7c_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_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-38-byke\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5632-2e614e1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605525170120935",
"status": "COMPLETED",
"status_changed_ts": "1605528159156464",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/24843",
"builder:Linux Viz",
"buildset:commit/git/9f22bfb49fe34720c34528ed56f5e8236d094d9c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9f22bfb49fe34720c34528ed56f5e8236d094d9c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028908621748864208",
"scheduler_job_id:chromium/Linux Viz",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8863478559053308864/+/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:4fe99364a0afd410",
"user_agent:luci-scheduler"
],
"updated_ts": "1605528159204216",
"url": "https://ci.chromium.org/b/8863478559053308864",
"utcnow_ts": "1605528167216442"
}
}
[12:02:47.228] Invocation finished in 50m2.760899356s with status SUCCEEDED