[22:21:49.343] New invocation is queued and will start shortly
[22:21:50.447] Starting the invocation (attempt 1)
[22:21:50.497] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:21:50.497] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:21:50.497] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9035117717599362192",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"bd6976f92ca50a5b577f790115b400d7a6bbeace\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9035117717599362192",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/bd6976f92ca50a5b577f790115b400d7a6bbeace",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd6976f92ca50a5b577f790115b400d7a6bbeace",
"gitiles_ref:refs/heads/master"
]
}
[22:21:52.280] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1599603711450910",
"id": "8869687654620714080",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bd6976f92ca50a5b577f790115b400d7a6bbeace\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1599603712083109",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/23815",
"builder:Linux Viz",
"buildset:commit/git/bd6976f92ca50a5b577f790115b400d7a6bbeace",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd6976f92ca50a5b577f790115b400d7a6bbeace",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9035117717599362192",
"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/8869687654620714080/+/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": "1599603712083260",
"url": "https://ci.chromium.org/b/8869687654620714080",
"utcnow_ts": "1599603712267199"
}
}
[22:21:52.280] Task URL: https://ci.chromium.org/b/8869687654620714080
[22:21:52.280] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:2:0) after 1m0s
[22:22:52.275] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:2:0)
[22:22:52.275] Timer tick, asking Buildbucket for the build status
[22:22:52.393] Build 8869687654620714080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:22:52.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:3:0) after 1m0s
[22:23:52.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:3:0)
[22:23:52.442] Timer tick, asking Buildbucket for the build status
[22:23:52.652] Build 8869687654620714080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:23:52.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:4:0) after 1m0s
[22:24:52.676] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:4:0)
[22:24:52.676] Timer tick, asking Buildbucket for the build status
[22:24:52.767] Build 8869687654620714080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:24:52.767] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:5:0) after 1m0s
[22:25:52.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:5:0)
[22:25:52.843] Timer tick, asking Buildbucket for the build status
[22:25:53.038] Build 8869687654620714080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:25:53.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:6:0) after 1m0s
[22:26:53.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:6:0)
[22:26:53.101] Timer tick, asking Buildbucket for the build status
[22:26:53.575] Build 8869687654620714080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:26:53.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:7:0) after 1m0s
[22:27:53.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:7:0)
[22:27:53.598] Timer tick, asking Buildbucket for the build status
[22:27:53.758] Build 8869687654620714080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:27:53.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:8:0) after 1m0s
[22:28:40.564] Received PubSub notification, asking Buildbucket for the build status
[22:28:40.651] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:53.805] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:8:0)
[22:28:53.805] Timer tick, asking Buildbucket for the build status
[22:28:53.914] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:53.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:10:0) after 1m0s
[22:29:53.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:10:0)
[22:29:53.968] Timer tick, asking Buildbucket for the build status
[22:29:54.042] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:54.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:11:0) after 1m0s
[22:30:54.114] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:11:0)
[22:30:54.114] Timer tick, asking Buildbucket for the build status
[22:30:54.212] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:54.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:12:0) after 1m0s
[22:31:54.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:12:0)
[22:31:54.231] Timer tick, asking Buildbucket for the build status
[22:31:54.321] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:54.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:13:0) after 1m0s
[22:32:54.403] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:13:0)
[22:32:54.403] Timer tick, asking Buildbucket for the build status
[22:32:57.679] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:57.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:14:0) after 1m0s
[22:33:57.805] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:14:0)
[22:33:57.805] Timer tick, asking Buildbucket for the build status
[22:33:58.089] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:58.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:15:0) after 1m0s
[22:34:58.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:15:0)
[22:34:58.166] Timer tick, asking Buildbucket for the build status
[22:34:58.265] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:58.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:16:0) after 1m0s
[22:35:58.309] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:16:0)
[22:35:58.309] Timer tick, asking Buildbucket for the build status
[22:35:58.453] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:58.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:17:0) after 1m0s
[22:36:58.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:17:0)
[22:36:58.483] Timer tick, asking Buildbucket for the build status
[22:36:58.550] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:58.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:18:0) after 1m0s
[22:37:58.640] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:18:0)
[22:37:58.640] Timer tick, asking Buildbucket for the build status
[22:37:58.799] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:58.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:19:0) after 1m0s
[22:38:58.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:19:0)
[22:38:58.822] Timer tick, asking Buildbucket for the build status
[22:38:58.915] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:58.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:20:0) after 1m0s
[22:39:58.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:20:0)
[22:39:58.930] Timer tick, asking Buildbucket for the build status
[22:39:58.992] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:58.992] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:21:0) after 1m0s
[22:40:59.049] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:21:0)
[22:40:59.049] Timer tick, asking Buildbucket for the build status
[22:40:59.248] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:59.248] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:22:0) after 1m0s
[22:41:59.261] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:22:0)
[22:41:59.261] Timer tick, asking Buildbucket for the build status
[22:41:59.478] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:59.478] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:23:0) after 1m0s
[22:42:59.505] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:23:0)
[22:42:59.505] Timer tick, asking Buildbucket for the build status
[22:43:00.492] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:00.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:24:0) after 1m0s
[22:44:00.547] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:24:0)
[22:44:00.547] Timer tick, asking Buildbucket for the build status
[22:44:00.651] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:00.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:25:0) after 1m0s
[22:45:02.005] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:25:0)
[22:45:02.005] Timer tick, asking Buildbucket for the build status
[22:45:02.102] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:02.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:26:0) after 1m0s
[22:46:02.762] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:26:0)
[22:46:02.762] Timer tick, asking Buildbucket for the build status
[22:46:02.851] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:02.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:27:0) after 1m0s
[22:47:02.999] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:27:0)
[22:47:02.999] Timer tick, asking Buildbucket for the build status
[22:47:03.637] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:03.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:28:0) after 1m0s
[22:48:03.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:28:0)
[22:48:03.792] Timer tick, asking Buildbucket for the build status
[22:48:03.886] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:03.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:29:0) after 1m0s
[22:49:03.901] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:29:0)
[22:49:03.901] Timer tick, asking Buildbucket for the build status
[22:49:04.040] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:04.040] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:30:0) after 1m0s
[22:50:04.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:30:0)
[22:50:04.129] Timer tick, asking Buildbucket for the build status
[22:50:04.276] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:04.277] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:31:0) after 1m0s
[22:51:04.426] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:31:0)
[22:51:04.426] Timer tick, asking Buildbucket for the build status
[22:51:04.533] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:04.533] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:32:0) after 1m0s
[22:52:04.735] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:32:0)
[22:52:04.735] Timer tick, asking Buildbucket for the build status
[22:52:04.890] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:04.890] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:33:0) after 1m0s
[22:53:04.949] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:33:0)
[22:53:04.949] Timer tick, asking Buildbucket for the build status
[22:53:05.112] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:05.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:34:0) after 1m0s
[22:54:05.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:34:0)
[22:54:05.367] Timer tick, asking Buildbucket for the build status
[22:54:05.454] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:05.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:35:0) after 1m0s
[22:55:05.671] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:35:0)
[22:55:05.671] Timer tick, asking Buildbucket for the build status
[22:55:06.756] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:06.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:36:0) after 1m0s
[22:56:06.999] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:36:0)
[22:56:06.999] Timer tick, asking Buildbucket for the build status
[22:56:07.105] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:07.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:37:0) after 1m0s
[22:57:07.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:37:0)
[22:57:07.362] Timer tick, asking Buildbucket for the build status
[22:57:07.517] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:07.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:38:0) after 1m0s
[22:58:07.610] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:38:0)
[22:58:07.610] Timer tick, asking Buildbucket for the build status
[22:58:07.726] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:07.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:39:0) after 1m0s
[22:59:07.738] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:39:0)
[22:59:07.739] Timer tick, asking Buildbucket for the build status
[22:59:07.813] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:07.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:40:0) after 1m0s
[23:00:07.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:40:0)
[23:00:07.837] Timer tick, asking Buildbucket for the build status
[23:00:08.457] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:08.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:41:0) after 1m0s
[23:01:08.530] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:41:0)
[23:01:08.530] Timer tick, asking Buildbucket for the build status
[23:01:08.650] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:08.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:42:0) after 1m0s
[23:02:08.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:42:0)
[23:02:08.807] Timer tick, asking Buildbucket for the build status
[23:02:09.277] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:09.277] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:43:0) after 1m0s
[23:03:09.634] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:43:0)
[23:03:09.634] Timer tick, asking Buildbucket for the build status
[23:03:09.702] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:09.702] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:44:0) after 1m0s
[23:04:09.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:44:0)
[23:04:09.795] Timer tick, asking Buildbucket for the build status
[23:04:09.876] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:09.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:45:0) after 1m0s
[23:05:09.934] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:45:0)
[23:05:09.934] Timer tick, asking Buildbucket for the build status
[23:05:10.036] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:10.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:46:0) after 1m0s
[23:06:10.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:46:0)
[23:06:10.012] Timer tick, asking Buildbucket for the build status
[23:06:10.416] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:10.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:47:0) after 1m0s
[23:07:10.527] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:47:0)
[23:07:10.527] Timer tick, asking Buildbucket for the build status
[23:07:10.877] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:10.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:48:0) after 1m0s
[23:08:10.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:48:0)
[23:08:10.992] Timer tick, asking Buildbucket for the build status
[23:08:12.335] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:12.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:49:0) after 1m0s
[23:09:13.047] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:49:0)
[23:09:13.047] Timer tick, asking Buildbucket for the build status
[23:09:13.643] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:13.643] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:50:0) after 1m0s
[23:10:13.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:50:0)
[23:10:13.790] Timer tick, asking Buildbucket for the build status
[23:10:13.896] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:13.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:51:0) after 1m0s
[23:11:13.967] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:51:0)
[23:11:13.967] Timer tick, asking Buildbucket for the build status
[23:11:14.053] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:14.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:52:0) after 1m0s
[23:12:14.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:52:0)
[23:12:14.344] Timer tick, asking Buildbucket for the build status
[23:12:14.562] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:14.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:53:0) after 1m0s
[23:13:14.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:53:0)
[23:13:14.724] Timer tick, asking Buildbucket for the build status
[23:13:14.786] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:14.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:54:0) after 1m0s
[23:14:14.895] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:54:0)
[23:14:14.895] Timer tick, asking Buildbucket for the build status
[23:14:15.147] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:15.147] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:55:0) after 1m0s
[23:15:15.255] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:55:0)
[23:15:15.255] Timer tick, asking Buildbucket for the build status
[23:15:16.345] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:16.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:56:0) after 1m0s
[23:16:16.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:56:0)
[23:16:16.459] Timer tick, asking Buildbucket for the build status
[23:16:16.582] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:16.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:57:0) after 1m0s
[23:17:16.669] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:57:0)
[23:17:16.669] Timer tick, asking Buildbucket for the build status
[23:17:16.862] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:16.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:58:0) after 1m0s
[23:18:16.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:58:0)
[23:18:16.928] Timer tick, asking Buildbucket for the build status
[23:18:16.995] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:16.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:59:0) after 1m0s
[23:19:17.042] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:59:0)
[23:19:17.042] Timer tick, asking Buildbucket for the build status
[23:19:17.248] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:17.248] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:60:0) after 1m0s
[23:20:17.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:60:0)
[23:20:17.371] Timer tick, asking Buildbucket for the build status
[23:20:17.522] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:17.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:61:0) after 1m0s
[23:21:17.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:61:0)
[23:21:17.621] Timer tick, asking Buildbucket for the build status
[23:21:17.751] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:17.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:62:0) after 1m0s
[23:22:17.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:62:0)
[23:22:17.893] Timer tick, asking Buildbucket for the build status
[23:22:18.317] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:18.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:63:0) after 1m0s
[23:23:18.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:63:0)
[23:23:18.422] Timer tick, asking Buildbucket for the build status
[23:23:18.587] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:18.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:64:0) after 1m0s
[23:24:18.636] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:64:0)
[23:24:18.636] Timer tick, asking Buildbucket for the build status
[23:24:18.747] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:18.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:65:0) after 1m0s
[23:25:18.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:65:0)
[23:25:18.793] Timer tick, asking Buildbucket for the build status
[23:25:19.102] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:19.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:66:0) after 1m0s
[23:26:19.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:66:0)
[23:26:19.128] Timer tick, asking Buildbucket for the build status
[23:26:19.218] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:19.218] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:67:0) after 1m0s
[23:27:19.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:67:0)
[23:27:19.247] Timer tick, asking Buildbucket for the build status
[23:27:19.725] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:19.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:68:0) after 1m0s
[23:28:19.783] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:68:0)
[23:28:19.783] Timer tick, asking Buildbucket for the build status
[23:28:19.870] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:19.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:69:0) after 1m0s
[23:29:19.879] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:69:0)
[23:29:19.879] Timer tick, asking Buildbucket for the build status
[23:29:19.936] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:19.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:70:0) after 1m0s
[23:30:19.964] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:70:0)
[23:30:19.964] Timer tick, asking Buildbucket for the build status
[23:30:20.067] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:20.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:71:0) after 1m0s
[23:31:20.114] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:71:0)
[23:31:20.114] Timer tick, asking Buildbucket for the build status
[23:31:20.204] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:20.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:72:0) after 1m0s
[23:32:20.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:72:0)
[23:32:20.244] Timer tick, asking Buildbucket for the build status
[23:32:20.384] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:20.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:73:0) after 1m0s
[23:33:20.444] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:73:0)
[23:33:20.444] Timer tick, asking Buildbucket for the build status
[23:33:20.536] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:20.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:74:0) after 1m0s
[23:34:20.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:74:0)
[23:34:20.620] Timer tick, asking Buildbucket for the build status
[23:34:20.745] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:20.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:75:0) after 1m0s
[23:35:21.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:75:0)
[23:35:21.215] Timer tick, asking Buildbucket for the build status
[23:35:21.329] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:21.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:76:0) after 1m0s
[23:36:22.197] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:76:0)
[23:36:22.197] Timer tick, asking Buildbucket for the build status
[23:36:23.102] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:23.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:77:0) after 1m0s
[23:37:23.155] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:77:0)
[23:37:23.155] Timer tick, asking Buildbucket for the build status
[23:37:23.290] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:23.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:78:0) after 1m0s
[23:38:23.378] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:78:0)
[23:38:23.379] Timer tick, asking Buildbucket for the build status
[23:38:23.472] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:23.472] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:79:0) after 1m0s
[23:39:24.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:79:0)
[23:39:24.296] Timer tick, asking Buildbucket for the build status
[23:39:24.394] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:24.394] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:80:0) after 1m0s
[23:40:24.719] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:80:0)
[23:40:24.719] Timer tick, asking Buildbucket for the build status
[23:40:24.803] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:24.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:81:0) after 1m0s
[23:41:24.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:81:0)
[23:41:24.992] Timer tick, asking Buildbucket for the build status
[23:41:25.103] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:25.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:82:0) after 1m0s
[23:42:25.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:82:0)
[23:42:25.406] Timer tick, asking Buildbucket for the build status
[23:42:25.576] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:25.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:83:0) after 1m0s
[23:43:25.725] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:83:0)
[23:43:25.725] Timer tick, asking Buildbucket for the build status
[23:43:25.821] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:25.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:84:0) after 1m0s
[23:44:25.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:84:0)
[23:44:25.913] Timer tick, asking Buildbucket for the build status
[23:44:26.960] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:26.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:85:0) after 1m0s
[23:45:27.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:85:0)
[23:45:27.003] Timer tick, asking Buildbucket for the build status
[23:45:27.261] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:27.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:86:0) after 1m0s
[23:46:27.394] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:86:0)
[23:46:27.395] Timer tick, asking Buildbucket for the build status
[23:46:27.546] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:27.546] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:87:0) after 1m0s
[23:47:27.581] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:87:0)
[23:47:27.581] Timer tick, asking Buildbucket for the build status
[23:47:27.878] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:27.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:88:0) after 1m0s
[23:48:27.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:88:0)
[23:48:27.937] Timer tick, asking Buildbucket for the build status
[23:48:28.029] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:28.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:89:0) after 1m0s
[23:49:28.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:89:0)
[23:49:28.167] Timer tick, asking Buildbucket for the build status
[23:49:28.260] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:28.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:90:0) after 1m0s
[23:50:28.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:90:0)
[23:50:28.323] Timer tick, asking Buildbucket for the build status
[23:50:28.386] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:28.386] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:91:0) after 1m0s
[23:51:28.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:91:0)
[23:51:28.450] Timer tick, asking Buildbucket for the build status
[23:51:32.424] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:32.424] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:92:0) after 1m0s
[23:52:32.475] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:92:0)
[23:52:32.475] Timer tick, asking Buildbucket for the build status
[23:52:32.832] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:32.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:93:0) after 1m0s
[23:53:32.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:93:0)
[23:53:32.889] Timer tick, asking Buildbucket for the build status
[23:53:33.070] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:33.070] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:94:0) after 1m0s
[23:54:33.502] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:94:0)
[23:54:33.503] Timer tick, asking Buildbucket for the build status
[23:54:33.843] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:33.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:95:0) after 1m0s
[23:55:34.277] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:95:0)
[23:55:34.277] Timer tick, asking Buildbucket for the build status
[23:55:34.371] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:34.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:96:0) after 1m0s
[23:56:34.612] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:96:0)
[23:56:34.612] Timer tick, asking Buildbucket for the build status
[23:56:34.698] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:34.698] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:97:0) after 1m0s
[23:57:34.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:97:0)
[23:57:34.825] Timer tick, asking Buildbucket for the build status
[23:57:35.821] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:35.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:98:0) after 1m0s
[23:58:35.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:98:0)
[23:58:35.929] Timer tick, asking Buildbucket for the build status
[23:58:36.129] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:36.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:99:0) after 1m0s
[23:59:36.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:99:0)
[23:59:36.414] Timer tick, asking Buildbucket for the build status
[23:59:36.638] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:36.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:100:0) after 1m0s
[00:00:36.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:100:0)
[00:00:36.928] Timer tick, asking Buildbucket for the build status
[00:00:37.089] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:37.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:101:0) after 1m0s
[00:01:37.236] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:101:0)
[00:01:37.236] Timer tick, asking Buildbucket for the build status
[00:01:37.401] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:37.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:102:0) after 1m0s
[00:02:37.451] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:102:0)
[00:02:37.451] Timer tick, asking Buildbucket for the build status
[00:02:37.596] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:37.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:103:0) after 1m0s
[00:03:37.737] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:103:0)
[00:03:37.737] Timer tick, asking Buildbucket for the build status
[00:03:37.805] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:37.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:104:0) after 1m0s
[00:04:38.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:104:0)
[00:04:38.002] Timer tick, asking Buildbucket for the build status
[00:04:38.105] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:38.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:105:0) after 1m0s
[00:05:38.251] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:105:0)
[00:05:38.251] Timer tick, asking Buildbucket for the build status
[00:05:38.327] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:38.327] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:106:0) after 1m0s
[00:06:38.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:106:0)
[00:06:38.373] Timer tick, asking Buildbucket for the build status
[00:06:38.589] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:38.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:107:0) after 1m0s
[00:07:38.687] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:107:0)
[00:07:38.687] Timer tick, asking Buildbucket for the build status
[00:07:39.068] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:39.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:108:0) after 1m0s
[00:08:39.225] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:108:0)
[00:08:39.225] Timer tick, asking Buildbucket for the build status
[00:08:39.356] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:39.356] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:109:0) after 1m0s
[00:09:39.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:109:0)
[00:09:39.523] Timer tick, asking Buildbucket for the build status
[00:09:39.870] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:39.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:110:0) after 1m0s
[00:10:40.190] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:110:0)
[00:10:40.190] Timer tick, asking Buildbucket for the build status
[00:10:40.379] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:40.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:111:0) after 1m0s
[00:11:40.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:111:0)
[00:11:40.693] Timer tick, asking Buildbucket for the build status
[00:11:40.925] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:40.925] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:112:0) after 1m0s
[00:12:41.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:112:0)
[00:12:41.012] Timer tick, asking Buildbucket for the build status
[00:12:41.124] Build 8869687654620714080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:41.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9035117717599362192:113:0) after 1m0s
[00:12:45.379] Received PubSub notification, asking Buildbucket for the build status
[00:12:45.611] Build 8869687654620714080: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:12:45.611] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1599610364516773",
"created_by": "project:chromium",
"created_ts": "1599603711450910",
"id": "8869687654620714080",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bd6976f92ca50a5b577f790115b400d7a6bbeace\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"bd6976f92ca50a5b577f790115b400d7a6bbeace\", \"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-86-ifsp\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Linux Viz\", \"buildnumber\": 23815, \"got_angle_revision\": \"e5882825af724d253f473dca7847eeb4c25ee3b3\", \"got_dawn_revision\": \"22e5e179fa288848b059b563f1d2b7c32e804eff\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"bd6976f92ca50a5b577f790115b400d7a6bbeace\", \"got_revision_cp\": \"refs/heads/master@{#805107}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"10121443c16deb0435be8ea61be54e3bee1b9855\", \"got_v8_revision\": \"3e2d6551eed76b7bdafb278b44c630965a840da8\", \"got_v8_revision_cp\": \"refs/heads/8.7.75@{#1}\", \"got_webrtc_revision\": \"9e9c8b7155d49c2f38b82fe9c9707181c57073c9\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32051}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bd6976f92ca50a5b577f790115b400d7a6bbeace\", \"swarm_hashes\": {\"blink_web_tests\": \"176de8dd07f6fcd9f910a62f0aadcbd028daf399\", \"browser_tests\": \"2e9687b56120c0410cfea5b8273a1b17a5a45f65\", \"content_browsertests\": \"dc4a7d5aca4a85f015cb9c24365d4750c560751f\"}, \"swarm_hashes_refs/heads/master(at){#805107}_without_patch\": {\"blink_web_tests\": \"176de8dd07f6fcd9f910a62f0aadcbd028daf399\", \"browser_tests\": \"2e9687b56120c0410cfea5b8273a1b17a5a45f65\", \"content_browsertests\": \"dc4a7d5aca4a85f015cb9c24365d4750c560751f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_86e58bbd6b6bbe4fd525ae4aceb0f1016b26510d266d058087ba8c800f68f4d9_v2\", \"builder_93a7e775fd8f3ff9ef99e2aeb686615c0006e7587b0f2c5be32706e8df4f86a4_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_9c30056936b0e6c113d792a7251a67e37568746469ef96a03dc78e237458f3d4_v2\", \"builder_bee64b857be6df8b7c1ab34ae7b2c6eab296c35495667b8b8424b2083d103b1e_v2\", \"builder_c026f2e480f12276e0d2f5bae999c627027c80faa2bd81b0976630cbcadc1979_v2\", \"builder_ddf530b99db2c48999a16b04f27f886d0f06df616543b36733eb8d0558bd23f5_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-86-ifsp\"], \"image\": [\"chrome-xenial-20081700-d9392568d25\"], \"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\": [\"5513-ee65082\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1599604119779798",
"status": "COMPLETED",
"status_changed_ts": "1599610364789721",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/23815",
"builder:Linux Viz",
"buildset:commit/git/bd6976f92ca50a5b577f790115b400d7a6bbeace",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd6976f92ca50a5b577f790115b400d7a6bbeace",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9035117717599362192",
"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/8869687654620714080/+/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:4e88a12965811e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1599610364798103",
"url": "https://ci.chromium.org/b/8869687654620714080",
"utcnow_ts": "1599610365601046"
}
}
[00:12:45.611] Invocation finished in 1h50m56.384783081s with status SUCCEEDED