[10:17:32.335] New invocation is queued and will start shortly
[10:17:33.437] Starting the invocation (attempt 1)
[10:17:33.484] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:17:33.484] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:17:33.484] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9034166718839247536",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c4c07dcc7616f2a8f6a4faddbeb3ef4a35d0566f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9034166718839247536",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/c4c07dcc7616f2a8f6a4faddbeb3ef4a35d0566f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4c07dcc7616f2a8f6a4faddbeb3ef4a35d0566f",
"gitiles_ref:refs/heads/master"
]
}
[10:17:34.206] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1600510653567560",
"id": "8868736656883798496",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4c07dcc7616f2a8f6a4faddbeb3ef4a35d0566f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1600510654070157",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/23955",
"builder:Linux Viz",
"buildset:commit/git/c4c07dcc7616f2a8f6a4faddbeb3ef4a35d0566f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4c07dcc7616f2a8f6a4faddbeb3ef4a35d0566f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034166718839247536",
"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/8868736656883798496/+/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": "1600510654070308",
"url": "https://ci.chromium.org/b/8868736656883798496",
"utcnow_ts": "1600510654198390"
}
}
[10:17:34.206] Task URL: https://ci.chromium.org/b/8868736656883798496
[10:17:34.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:2:0) after 1m0s
[10:17:35.291] Received PubSub notification, asking Buildbucket for the build status
[10:17:35.398] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:34.226] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:2:0)
[10:18:34.226] Timer tick, asking Buildbucket for the build status
[10:18:34.304] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:34.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:4:0) after 1m0s
[10:19:34.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:4:0)
[10:19:34.321] Timer tick, asking Buildbucket for the build status
[10:19:34.432] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:34.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:5:0) after 1m0s
[10:20:34.466] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:5:0)
[10:20:34.466] Timer tick, asking Buildbucket for the build status
[10:20:34.542] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:34.542] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:6:0) after 1m0s
[10:21:34.639] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:6:0)
[10:21:34.639] Timer tick, asking Buildbucket for the build status
[10:21:34.754] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:34.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:7:0) after 1m0s
[10:22:34.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:7:0)
[10:22:34.837] Timer tick, asking Buildbucket for the build status
[10:22:35.224] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:35.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:8:0) after 1m0s
[10:23:35.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:8:0)
[10:23:35.247] Timer tick, asking Buildbucket for the build status
[10:23:35.333] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:35.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:9:0) after 1m0s
[10:24:35.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:9:0)
[10:24:35.352] Timer tick, asking Buildbucket for the build status
[10:24:35.438] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:35.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:10:0) after 1m0s
[10:25:35.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:10:0)
[10:25:35.511] Timer tick, asking Buildbucket for the build status
[10:25:35.914] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:35.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:11:0) after 1m0s
[10:26:35.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:11:0)
[10:26:35.991] Timer tick, asking Buildbucket for the build status
[10:26:36.194] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:36.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:12:0) after 1m0s
[10:27:36.219] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:12:0)
[10:27:36.219] Timer tick, asking Buildbucket for the build status
[10:27:36.585] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:36.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:13:0) after 1m0s
[10:28:36.613] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:13:0)
[10:28:36.613] Timer tick, asking Buildbucket for the build status
[10:28:36.682] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:36.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:14:0) after 1m0s
[10:29:36.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:14:0)
[10:29:36.711] Timer tick, asking Buildbucket for the build status
[10:29:36.996] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:36.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:15:0) after 1m0s
[10:30:37.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:15:0)
[10:30:37.068] Timer tick, asking Buildbucket for the build status
[10:30:37.144] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:37.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:16:0) after 1m0s
[10:31:37.153] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:16:0)
[10:31:37.153] Timer tick, asking Buildbucket for the build status
[10:31:37.588] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:37.588] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:17:0) after 1m0s
[10:32:37.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:17:0)
[10:32:37.667] Timer tick, asking Buildbucket for the build status
[10:32:37.825] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:37.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:18:0) after 1m0s
[10:33:37.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:18:0)
[10:33:37.848] Timer tick, asking Buildbucket for the build status
[10:33:37.918] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:37.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:19:0) after 1m0s
[10:34:37.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:19:0)
[10:34:37.939] Timer tick, asking Buildbucket for the build status
[10:34:37.993] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:37.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:20:0) after 1m0s
[10:35:38.019] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:20:0)
[10:35:38.019] Timer tick, asking Buildbucket for the build status
[10:35:38.236] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:38.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:21:0) after 1m0s
[10:36:38.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:21:0)
[10:36:38.294] Timer tick, asking Buildbucket for the build status
[10:36:38.487] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:38.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:22:0) after 1m0s
[10:37:38.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:22:0)
[10:37:38.518] Timer tick, asking Buildbucket for the build status
[10:37:38.622] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:38.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:23:0) after 1m0s
[10:38:38.657] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:23:0)
[10:38:38.657] Timer tick, asking Buildbucket for the build status
[10:38:38.743] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:38.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:24:0) after 1m0s
[10:39:38.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:24:0)
[10:39:38.803] Timer tick, asking Buildbucket for the build status
[10:39:39.205] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:39.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:25:0) after 1m0s
[10:40:39.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:25:0)
[10:40:39.266] Timer tick, asking Buildbucket for the build status
[10:40:39.322] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:39.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:26:0) after 1m0s
[10:41:39.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:26:0)
[10:41:39.339] Timer tick, asking Buildbucket for the build status
[10:41:39.423] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:39.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:27:0) after 1m0s
[10:42:39.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:27:0)
[10:42:39.532] Timer tick, asking Buildbucket for the build status
[10:42:39.652] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:39.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:28:0) after 1m0s
[10:43:39.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:28:0)
[10:43:39.675] Timer tick, asking Buildbucket for the build status
[10:43:39.744] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:39.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:29:0) after 1m0s
[10:44:39.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:29:0)
[10:44:39.833] Timer tick, asking Buildbucket for the build status
[10:44:39.995] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:39.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:30:0) after 1m0s
[10:45:40.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:30:0)
[10:45:40.059] Timer tick, asking Buildbucket for the build status
[10:45:40.138] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:40.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:31:0) after 1m0s
[10:46:40.377] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:31:0)
[10:46:40.377] Timer tick, asking Buildbucket for the build status
[10:46:40.721] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:40.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:32:0) after 1m0s
[10:47:40.755] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:32:0)
[10:47:40.755] Timer tick, asking Buildbucket for the build status
[10:47:40.883] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:40.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:33:0) after 1m0s
[10:48:40.962] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:33:0)
[10:48:40.962] Timer tick, asking Buildbucket for the build status
[10:48:41.107] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:41.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:34:0) after 1m0s
[10:49:41.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:34:0)
[10:49:41.266] Timer tick, asking Buildbucket for the build status
[10:49:41.396] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:41.396] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:35:0) after 1m0s
[10:50:41.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:35:0)
[10:50:41.496] Timer tick, asking Buildbucket for the build status
[10:50:41.571] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:41.571] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:36:0) after 1m0s
[10:51:41.604] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:36:0)
[10:51:41.604] Timer tick, asking Buildbucket for the build status
[10:51:41.953] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:41.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:37:0) after 1m0s
[10:52:42.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:37:0)
[10:52:42.001] Timer tick, asking Buildbucket for the build status
[10:52:42.313] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:42.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:38:0) after 1m0s
[10:53:42.342] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:38:0)
[10:53:42.342] Timer tick, asking Buildbucket for the build status
[10:53:42.438] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:42.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:39:0) after 1m0s
[10:54:42.504] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:39:0)
[10:54:42.504] Timer tick, asking Buildbucket for the build status
[10:54:42.577] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:42.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:40:0) after 1m0s
[10:55:42.789] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:40:0)
[10:55:42.789] Timer tick, asking Buildbucket for the build status
[10:55:42.845] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:42.845] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:41:0) after 1m0s
[10:56:42.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:41:0)
[10:56:42.873] Timer tick, asking Buildbucket for the build status
[10:56:43.352] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:43.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:42:0) after 1m0s
[10:57:43.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:42:0)
[10:57:43.480] Timer tick, asking Buildbucket for the build status
[10:57:43.798] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:43.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:43:0) after 1m0s
[10:58:43.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:43:0)
[10:58:43.794] Timer tick, asking Buildbucket for the build status
[10:58:43.876] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:43.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:44:0) after 1m0s
[10:59:43.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:44:0)
[10:59:43.931] Timer tick, asking Buildbucket for the build status
[10:59:43.991] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:43.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:45:0) after 1m0s
[11:00:44.161] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:45:0)
[11:00:44.161] Timer tick, asking Buildbucket for the build status
[11:00:44.286] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:44.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:46:0) after 1m0s
[11:01:44.308] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:46:0)
[11:01:44.308] Timer tick, asking Buildbucket for the build status
[11:01:44.437] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:44.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:47:0) after 1m0s
[11:02:44.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:47:0)
[11:02:44.558] Timer tick, asking Buildbucket for the build status
[11:02:45.163] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:45.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:48:0) after 1m0s
[11:03:45.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:48:0)
[11:03:45.137] Timer tick, asking Buildbucket for the build status
[11:03:45.201] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:45.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:49:0) after 1m0s
[11:04:45.282] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:49:0)
[11:04:45.282] Timer tick, asking Buildbucket for the build status
[11:04:45.524] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:45.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:50:0) after 1m0s
[11:05:45.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:50:0)
[11:05:45.664] Timer tick, asking Buildbucket for the build status
[11:05:45.734] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:45.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:51:0) after 1m0s
[11:06:45.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:51:0)
[11:06:45.981] Timer tick, asking Buildbucket for the build status
[11:06:46.106] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:46.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:52:0) after 1m0s
[11:07:46.392] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:52:0)
[11:07:46.392] Timer tick, asking Buildbucket for the build status
[11:07:46.607] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:46.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:53:0) after 1m0s
[11:08:46.788] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:53:0)
[11:08:46.788] Timer tick, asking Buildbucket for the build status
[11:08:46.860] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:46.860] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:54:0) after 1m0s
[11:09:46.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:54:0)
[11:09:46.950] Timer tick, asking Buildbucket for the build status
[11:09:47.122] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:47.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:55:0) after 1m0s
[11:10:47.249] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:55:0)
[11:10:47.249] Timer tick, asking Buildbucket for the build status
[11:10:47.325] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:47.325] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:56:0) after 1m0s
[11:11:47.447] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:56:0)
[11:11:47.447] Timer tick, asking Buildbucket for the build status
[11:11:47.790] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:47.790] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:57:0) after 1m0s
[11:12:47.818] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:57:0)
[11:12:47.818] Timer tick, asking Buildbucket for the build status
[11:12:47.968] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:47.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:58:0) after 1m0s
[11:13:47.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:58:0)
[11:13:47.994] Timer tick, asking Buildbucket for the build status
[11:13:48.086] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:48.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:59:0) after 1m0s
[11:14:48.131] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:59:0)
[11:14:48.131] Timer tick, asking Buildbucket for the build status
[11:14:48.326] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:48.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:60:0) after 1m0s
[11:15:48.493] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:60:0)
[11:15:48.493] Timer tick, asking Buildbucket for the build status
[11:15:48.572] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:48.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:61:0) after 1m0s
[11:16:48.720] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:61:0)
[11:16:48.720] Timer tick, asking Buildbucket for the build status
[11:16:48.803] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:48.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:62:0) after 1m0s
[11:17:48.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:62:0)
[11:17:48.853] Timer tick, asking Buildbucket for the build status
[11:17:49.277] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:49.277] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:63:0) after 1m0s
[11:18:49.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:63:0)
[11:18:49.318] Timer tick, asking Buildbucket for the build status
[11:18:49.538] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:49.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:64:0) after 1m0s
[11:19:49.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:64:0)
[11:19:49.591] Timer tick, asking Buildbucket for the build status
[11:19:49.658] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:49.658] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:65:0) after 1m0s
[11:20:49.780] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:65:0)
[11:20:49.780] Timer tick, asking Buildbucket for the build status
[11:20:49.866] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:49.866] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:66:0) after 1m0s
[11:21:49.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:66:0)
[11:21:49.903] Timer tick, asking Buildbucket for the build status
[11:21:50.162] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:50.162] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:67:0) after 1m0s
[11:22:50.161] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:67:0)
[11:22:50.161] Timer tick, asking Buildbucket for the build status
[11:22:50.273] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:50.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:68:0) after 1m0s
[11:23:50.345] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:68:0)
[11:23:50.345] Timer tick, asking Buildbucket for the build status
[11:23:50.405] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:50.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:69:0) after 1m0s
[11:24:50.470] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:69:0)
[11:24:50.470] Timer tick, asking Buildbucket for the build status
[11:24:50.535] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:50.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:70:0) after 1m0s
[11:25:50.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:70:0)
[11:25:50.619] Timer tick, asking Buildbucket for the build status
[11:25:50.705] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:50.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:71:0) after 1m0s
[11:26:50.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:71:0)
[11:26:50.743] Timer tick, asking Buildbucket for the build status
[11:26:50.807] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:50.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:72:0) after 1m0s
[11:27:50.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:72:0)
[11:27:50.915] Timer tick, asking Buildbucket for the build status
[11:27:51.038] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:51.040] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:73:0) after 1m0s
[11:28:51.133] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:73:0)
[11:28:51.133] Timer tick, asking Buildbucket for the build status
[11:28:51.426] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:51.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:74:0) after 1m0s
[11:29:51.533] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:74:0)
[11:29:51.533] Timer tick, asking Buildbucket for the build status
[11:29:51.614] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:51.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:75:0) after 1m0s
[11:30:51.611] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:75:0)
[11:30:51.611] Timer tick, asking Buildbucket for the build status
[11:30:51.677] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:51.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:76:0) after 1m0s
[11:31:51.746] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:76:0)
[11:31:51.746] Timer tick, asking Buildbucket for the build status
[11:31:51.816] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:51.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:77:0) after 1m0s
[11:32:51.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:77:0)
[11:32:51.844] Timer tick, asking Buildbucket for the build status
[11:32:52.018] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:52.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:78:0) after 1m0s
[11:33:52.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:78:0)
[11:33:52.103] Timer tick, asking Buildbucket for the build status
[11:33:52.512] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:52.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:79:0) after 1m0s
[11:34:52.544] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:79:0)
[11:34:52.544] Timer tick, asking Buildbucket for the build status
[11:34:52.622] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:52.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:80:0) after 1m0s
[11:35:52.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:80:0)
[11:35:52.658] Timer tick, asking Buildbucket for the build status
[11:35:52.726] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:52.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:81:0) after 1m0s
[11:36:52.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:81:0)
[11:36:52.863] Timer tick, asking Buildbucket for the build status
[11:36:52.950] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:52.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:82:0) after 1m0s
[11:37:53.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:82:0)
[11:37:53.012] Timer tick, asking Buildbucket for the build status
[11:37:53.137] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:53.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:83:0) after 1m0s
[11:38:53.206] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:83:0)
[11:38:53.206] Timer tick, asking Buildbucket for the build status
[11:38:53.291] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:53.291] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:84:0) after 1m0s
[11:39:53.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:84:0)
[11:39:53.326] Timer tick, asking Buildbucket for the build status
[11:39:53.506] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:53.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:85:0) after 1m0s
[11:40:53.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:85:0)
[11:40:53.651] Timer tick, asking Buildbucket for the build status
[11:40:54.045] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:54.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:86:0) after 1m0s
[11:41:54.118] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:86:0)
[11:41:54.118] Timer tick, asking Buildbucket for the build status
[11:41:54.197] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:54.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:87:0) after 1m0s
[11:42:54.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:87:0)
[11:42:54.260] Timer tick, asking Buildbucket for the build status
[11:42:54.472] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:54.472] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:88:0) after 1m0s
[11:43:54.671] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:88:0)
[11:43:54.671] Timer tick, asking Buildbucket for the build status
[11:43:54.772] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:54.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:89:0) after 1m0s
[11:44:54.858] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:89:0)
[11:44:54.858] Timer tick, asking Buildbucket for the build status
[11:44:54.929] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:54.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:90:0) after 1m0s
[11:45:55.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:90:0)
[11:45:55.027] Timer tick, asking Buildbucket for the build status
[11:45:55.120] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:55.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:91:0) after 1m0s
[11:46:55.222] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:91:0)
[11:46:55.223] Timer tick, asking Buildbucket for the build status
[11:46:55.350] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:55.350] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:92:0) after 1m0s
[11:47:55.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:92:0)
[11:47:55.409] Timer tick, asking Buildbucket for the build status
[11:47:55.523] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:55.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:93:0) after 1m0s
[11:48:55.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:93:0)
[11:48:55.608] Timer tick, asking Buildbucket for the build status
[11:48:55.818] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:55.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:94:0) after 1m0s
[11:49:55.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:94:0)
[11:49:55.857] Timer tick, asking Buildbucket for the build status
[11:49:55.981] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:55.981] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:95:0) after 1m0s
[11:50:56.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:95:0)
[11:50:56.025] Timer tick, asking Buildbucket for the build status
[11:50:56.311] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:56.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:96:0) after 1m0s
[11:51:56.509] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:96:0)
[11:51:56.509] Timer tick, asking Buildbucket for the build status
[11:51:56.632] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:56.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:97:0) after 1m0s
[11:52:56.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:97:0)
[11:52:56.699] Timer tick, asking Buildbucket for the build status
[11:52:56.924] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:56.924] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:98:0) after 1m0s
[11:53:56.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:98:0)
[11:53:56.979] Timer tick, asking Buildbucket for the build status
[11:53:57.440] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:57.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:99:0) after 1m0s
[11:54:57.469] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:99:0)
[11:54:57.469] Timer tick, asking Buildbucket for the build status
[11:54:57.625] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:57.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:100:0) after 1m0s
[11:55:57.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:100:0)
[11:55:57.714] Timer tick, asking Buildbucket for the build status
[11:55:57.997] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:57.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:101:0) after 1m0s
[11:56:58.022] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:101:0)
[11:56:58.022] Timer tick, asking Buildbucket for the build status
[11:56:58.123] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:58.123] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:102:0) after 1m0s
[11:57:58.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:102:0)
[11:57:58.117] Timer tick, asking Buildbucket for the build status
[11:57:58.392] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:58.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:103:0) after 1m0s
[11:58:58.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:103:0)
[11:58:58.521] Timer tick, asking Buildbucket for the build status
[11:58:58.647] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:58.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:104:0) after 1m0s
[11:59:58.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:104:0)
[11:59:58.691] Timer tick, asking Buildbucket for the build status
[11:59:58.756] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:58.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:105:0) after 1m0s
[12:00:58.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:105:0)
[12:00:58.795] Timer tick, asking Buildbucket for the build status
[12:00:59.106] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:59.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:106:0) after 1m0s
[12:01:59.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:106:0)
[12:01:59.260] Timer tick, asking Buildbucket for the build status
[12:01:59.335] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:59.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:107:0) after 1m0s
[12:02:59.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:107:0)
[12:02:59.442] Timer tick, asking Buildbucket for the build status
[12:02:59.556] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:59.557] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:108:0) after 1m0s
[12:03:59.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:108:0)
[12:03:59.682] Timer tick, asking Buildbucket for the build status
[12:03:59.758] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:59.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:109:0) after 1m0s
[12:04:59.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:109:0)
[12:04:59.786] Timer tick, asking Buildbucket for the build status
[12:05:00.170] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:00.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:110:0) after 1m0s
[12:06:00.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:110:0)
[12:06:00.231] Timer tick, asking Buildbucket for the build status
[12:06:00.333] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:00.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:111:0) after 1m0s
[12:07:00.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:111:0)
[12:07:00.409] Timer tick, asking Buildbucket for the build status
[12:07:00.530] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:00.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:112:0) after 1m0s
[12:08:01.470] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:112:0)
[12:08:01.470] Timer tick, asking Buildbucket for the build status
[12:08:01.990] Build 8868736656883798496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:01.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9034166718839247536:113:0) after 1m0s
[12:08:47.836] Received PubSub notification, asking Buildbucket for the build status
[12:08:47.942] Build 8868736656883798496: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:08:47.942] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1600517327231754",
"created_by": "project:chromium",
"created_ts": "1600510653567560",
"id": "8868736656883798496",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4c07dcc7616f2a8f6a4faddbeb3ef4a35d0566f\"}}",
"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\": \"c4c07dcc7616f2a8f6a4faddbeb3ef4a35d0566f\", \"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-20-6way\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Linux Viz\", \"buildnumber\": 23955, \"got_angle_revision\": \"f6f206018caf4008d52a311fe07466ad08bef808\", \"got_dawn_revision\": \"dcd37fa4f47663d1a68c1c7fb10738b6ea0e0a4c\", \"got_nacl_revision\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"got_revision\": \"c4c07dcc7616f2a8f6a4faddbeb3ef4a35d0566f\", \"got_revision_cp\": \"refs/heads/master@{#808676}\", \"got_swarming_client_revision\": \"44c13d73156581ea09b9389001e58c23a4b8d70a\", \"got_swiftshader_revision\": \"fe878dedd5addbedab4033c0cb6b19bbbe04f8e4\", \"got_v8_revision\": \"80dc1e8055bca07e8da6162bace5ee87f23faccf\", \"got_v8_revision_cp\": \"refs/heads/8.7.142@{#1}\", \"got_webrtc_revision\": \"14dbf82961c32ae9133bb672c88e146942062ada\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32143}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4c07dcc7616f2a8f6a4faddbeb3ef4a35d0566f\", \"swarm_hashes\": {\"blink_web_tests\": \"c2b6af356161a4670b106632cc9c2e0684ceb0a4\", \"browser_tests\": \"3145033adefe5d681891a1a45f06698e39e89cc0\", \"content_browsertests\": \"46f85066ae97f8f8303c745035e29d718f8423ce\"}, \"swarm_hashes_refs/heads/master(at){#808676}_without_patch\": {\"blink_web_tests\": \"c2b6af356161a4670b106632cc9c2e0684ceb0a4\", \"browser_tests\": \"3145033adefe5d681891a1a45f06698e39e89cc0\", \"content_browsertests\": \"46f85066ae97f8f8303c745035e29d718f8423ce\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_957c0f1a1c74c3ada6665996f2ff614223d5da32e2cc2316ff7cc4c9c4beae5c_v2\", \"builder_b5fdc4d6fcf65310851ade29ad6455d2ed3867ce433138301aea564742ea0410_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"builder_ee5c11e7a332f55fd7a24d7319a67a6829cd4b81b48e997032d91622b214e82b_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-20-6way\"], \"image\": [\"chrome-xenial-20091300-9b3346fad90\"], \"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\": [\"5531-8ab19d9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1600510654628061",
"status": "COMPLETED",
"status_changed_ts": "1600517327540574",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/23955",
"builder:Linux Viz",
"buildset:commit/git/c4c07dcc7616f2a8f6a4faddbeb3ef4a35d0566f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4c07dcc7616f2a8f6a4faddbeb3ef4a35d0566f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034166718839247536",
"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/8868736656883798496/+/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:4ebeafff4dd7b410",
"user_agent:luci-scheduler"
],
"updated_ts": "1600517327547892",
"url": "https://ci.chromium.org/b/8868736656883798496",
"utcnow_ts": "1600517327935824"
}
}
[12:08:47.942] Invocation finished in 1h51m15.624385051s with status SUCCEEDED