[09:25:27.233] New invocation is queued and will start shortly
[09:25:28.317] Starting the invocation (attempt 1)
[09:25:28.349] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:25:28.349] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:25:28.349] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025110299104612832",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3e6cdd251797b1f3ce80f88d84fdd4f94c3e8079\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9025110299104612832",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/3e6cdd251797b1f3ce80f88d84fdd4f94c3e8079",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3e6cdd251797b1f3ce80f88d84fdd4f94c3e8079",
"gitiles_ref:refs/heads/master"
]
}
[09:25:28.934] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609147528428419",
"id": "8859680237189367376",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3e6cdd251797b1f3ce80f88d84fdd4f94c3e8079\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609147528801506",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/25581",
"builder:Linux Viz",
"buildset:commit/git/3e6cdd251797b1f3ce80f88d84fdd4f94c3e8079",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3e6cdd251797b1f3ce80f88d84fdd4f94c3e8079",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025110299104612832",
"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/8859680237189367376/+/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": "1609147528801613",
"url": "https://ci.chromium.org/b/8859680237189367376",
"utcnow_ts": "1609147528925517"
}
}
[09:25:28.934] Task URL: https://ci.chromium.org/b/8859680237189367376
[09:25:28.934] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:2:0) after 1m0s
[09:26:28.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:2:0)
[09:26:28.994] Timer tick, asking Buildbucket for the build status
[09:26:29.097] Build 8859680237189367376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:26:29.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:3:0) after 1m0s
[09:27:29.091] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:3:0)
[09:27:29.091] Timer tick, asking Buildbucket for the build status
[09:27:29.155] Build 8859680237189367376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:27:29.155] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:4:0) after 1m0s
[09:28:29.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:4:0)
[09:28:29.173] Timer tick, asking Buildbucket for the build status
[09:28:29.580] Build 8859680237189367376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:28:29.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:5:0) after 1m0s
[09:29:29.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:5:0)
[09:29:29.693] Timer tick, asking Buildbucket for the build status
[09:29:30.603] Build 8859680237189367376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:29:30.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:6:0) after 1m0s
[09:30:30.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:6:0)
[09:30:30.726] Timer tick, asking Buildbucket for the build status
[09:30:30.818] Build 8859680237189367376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:30:30.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:7:0) after 1m0s
[09:31:03.793] Received PubSub notification, asking Buildbucket for the build status
[09:31:03.860] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:30.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:7:0)
[09:31:30.846] Timer tick, asking Buildbucket for the build status
[09:31:30.932] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:30.932] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:9:0) after 1m0s
[09:32:31.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:9:0)
[09:32:31.074] Timer tick, asking Buildbucket for the build status
[09:32:31.190] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:31.190] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:10:0) after 1m0s
[09:33:31.345] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:10:0)
[09:33:31.345] Timer tick, asking Buildbucket for the build status
[09:33:31.402] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:31.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:11:0) after 1m0s
[09:34:31.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:11:0)
[09:34:31.477] Timer tick, asking Buildbucket for the build status
[09:34:31.686] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:31.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:12:0) after 1m0s
[09:35:31.719] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:12:0)
[09:35:31.719] Timer tick, asking Buildbucket for the build status
[09:35:31.851] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:31.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:13:0) after 1m0s
[09:36:31.905] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:13:0)
[09:36:31.905] Timer tick, asking Buildbucket for the build status
[09:36:32.356] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:32.356] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:14:0) after 1m0s
[09:37:32.343] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:14:0)
[09:37:32.343] Timer tick, asking Buildbucket for the build status
[09:37:32.393] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:32.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:15:0) after 1m0s
[09:38:32.475] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:15:0)
[09:38:32.476] Timer tick, asking Buildbucket for the build status
[09:38:32.756] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:32.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:16:0) after 1m0s
[09:39:32.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:16:0)
[09:39:32.806] Timer tick, asking Buildbucket for the build status
[09:39:33.257] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:33.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:17:0) after 1m0s
[09:40:33.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:17:0)
[09:40:33.283] Timer tick, asking Buildbucket for the build status
[09:40:33.334] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:33.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:18:0) after 1m0s
[09:41:33.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:18:0)
[09:41:33.354] Timer tick, asking Buildbucket for the build status
[09:41:33.447] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:33.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:19:0) after 1m0s
[09:42:33.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:19:0)
[09:42:33.474] Timer tick, asking Buildbucket for the build status
[09:42:33.531] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:33.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:20:0) after 1m0s
[09:43:33.557] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:20:0)
[09:43:33.557] Timer tick, asking Buildbucket for the build status
[09:43:33.663] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:33.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:21:0) after 1m0s
[09:44:33.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:21:0)
[09:44:33.724] Timer tick, asking Buildbucket for the build status
[09:44:33.846] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:33.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:22:0) after 1m0s
[09:45:33.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:22:0)
[09:45:33.893] Timer tick, asking Buildbucket for the build status
[09:45:34.294] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:34.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:23:0) after 1m0s
[09:46:34.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:23:0)
[09:46:34.316] Timer tick, asking Buildbucket for the build status
[09:46:34.422] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:34.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:24:0) after 1m0s
[09:47:34.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:24:0)
[09:47:34.465] Timer tick, asking Buildbucket for the build status
[09:47:34.525] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:34.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:25:0) after 1m0s
[09:48:34.652] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:25:0)
[09:48:34.652] Timer tick, asking Buildbucket for the build status
[09:48:34.730] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:34.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:26:0) after 1m0s
[09:49:34.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:26:0)
[09:49:34.796] Timer tick, asking Buildbucket for the build status
[09:49:34.879] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:34.879] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:27:0) after 1m0s
[09:50:35.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:27:0)
[09:50:35.039] Timer tick, asking Buildbucket for the build status
[09:50:35.102] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:35.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:28:0) after 1m0s
[09:51:35.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:28:0)
[09:51:35.177] Timer tick, asking Buildbucket for the build status
[09:51:35.314] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:35.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:29:0) after 1m0s
[09:52:35.403] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:29:0)
[09:52:35.403] Timer tick, asking Buildbucket for the build status
[09:52:35.459] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:35.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:30:0) after 1m0s
[09:53:35.570] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:30:0)
[09:53:35.570] Timer tick, asking Buildbucket for the build status
[09:53:35.623] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:35.623] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:31:0) after 1m0s
[09:54:35.681] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:31:0)
[09:54:35.681] Timer tick, asking Buildbucket for the build status
[09:54:35.737] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:35.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:32:0) after 1m0s
[09:55:35.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:32:0)
[09:55:35.809] Timer tick, asking Buildbucket for the build status
[09:55:36.316] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:36.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:33:0) after 1m0s
[09:56:36.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:33:0)
[09:56:36.366] Timer tick, asking Buildbucket for the build status
[09:56:36.453] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:36.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:34:0) after 1m0s
[09:57:36.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:34:0)
[09:57:36.578] Timer tick, asking Buildbucket for the build status
[09:57:36.723] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:36.723] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:35:0) after 1m0s
[09:58:36.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:35:0)
[09:58:36.848] Timer tick, asking Buildbucket for the build status
[09:58:36.909] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:36.909] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:36:0) after 1m0s
[09:59:39.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:36:0)
[09:59:39.012] Timer tick, asking Buildbucket for the build status
[09:59:39.089] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:39.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:37:0) after 1m0s
[10:00:39.132] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:37:0)
[10:00:39.132] Timer tick, asking Buildbucket for the build status
[10:00:39.195] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:39.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:38:0) after 1m0s
[10:01:39.314] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:38:0)
[10:01:39.314] Timer tick, asking Buildbucket for the build status
[10:01:39.455] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:39.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:39:0) after 1m0s
[10:02:39.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:39:0)
[10:02:39.464] Timer tick, asking Buildbucket for the build status
[10:02:39.525] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:39.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:40:0) after 1m0s
[10:03:39.574] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:40:0)
[10:03:39.574] Timer tick, asking Buildbucket for the build status
[10:03:39.628] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:39.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:41:0) after 1m0s
[10:04:39.687] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:41:0)
[10:04:39.687] Timer tick, asking Buildbucket for the build status
[10:04:39.794] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:39.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:42:0) after 1m0s
[10:05:39.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:42:0)
[10:05:39.842] Timer tick, asking Buildbucket for the build status
[10:05:39.903] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:39.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:43:0) after 1m0s
[10:06:39.953] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:43:0)
[10:06:39.953] Timer tick, asking Buildbucket for the build status
[10:06:40.035] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:40.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:44:0) after 1m0s
[10:07:40.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:44:0)
[10:07:40.158] Timer tick, asking Buildbucket for the build status
[10:07:40.224] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:40.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:45:0) after 1m0s
[10:08:40.392] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:45:0)
[10:08:40.392] Timer tick, asking Buildbucket for the build status
[10:08:40.465] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:40.465] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:46:0) after 1m0s
[10:09:40.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:46:0)
[10:09:40.553] Timer tick, asking Buildbucket for the build status
[10:09:40.625] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:40.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:47:0) after 1m0s
[10:10:40.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:47:0)
[10:10:40.707] Timer tick, asking Buildbucket for the build status
[10:10:40.768] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:40.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:48:0) after 1m0s
[10:11:40.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:48:0)
[10:11:40.857] Timer tick, asking Buildbucket for the build status
[10:11:41.012] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:41.012] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:49:0) after 1m0s
[10:12:41.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:49:0)
[10:12:41.015] Timer tick, asking Buildbucket for the build status
[10:12:41.202] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:41.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:50:0) after 1m0s
[10:13:41.275] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:50:0)
[10:13:41.275] Timer tick, asking Buildbucket for the build status
[10:13:41.348] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:41.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:51:0) after 1m0s
[10:14:41.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:51:0)
[10:14:41.437] Timer tick, asking Buildbucket for the build status
[10:14:41.704] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:41.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:52:0) after 1m0s
[10:15:41.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:52:0)
[10:15:41.842] Timer tick, asking Buildbucket for the build status
[10:15:41.978] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:41.978] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:53:0) after 1m0s
[10:16:42.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:53:0)
[10:16:42.035] Timer tick, asking Buildbucket for the build status
[10:16:42.133] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:42.133] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:54:0) after 1m0s
[10:17:42.252] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:54:0)
[10:17:42.252] Timer tick, asking Buildbucket for the build status
[10:17:42.319] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:42.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:55:0) after 1m0s
[10:18:42.427] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:55:0)
[10:18:42.427] Timer tick, asking Buildbucket for the build status
[10:18:42.477] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:42.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:56:0) after 1m0s
[10:19:42.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:56:0)
[10:19:42.607] Timer tick, asking Buildbucket for the build status
[10:19:42.661] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:42.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:57:0) after 1m0s
[10:20:42.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:57:0)
[10:20:42.686] Timer tick, asking Buildbucket for the build status
[10:20:42.740] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:42.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:58:0) after 1m0s
[10:21:42.850] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:58:0)
[10:21:42.850] Timer tick, asking Buildbucket for the build status
[10:21:42.967] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:42.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:59:0) after 1m0s
[10:22:43.057] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:59:0)
[10:22:43.057] Timer tick, asking Buildbucket for the build status
[10:22:43.291] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:43.291] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:60:0) after 1m0s
[10:23:43.314] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:60:0)
[10:23:43.314] Timer tick, asking Buildbucket for the build status
[10:23:43.375] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:43.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:61:0) after 1m0s
[10:24:43.413] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:61:0)
[10:24:43.413] Timer tick, asking Buildbucket for the build status
[10:24:43.488] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:43.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:62:0) after 1m0s
[10:25:43.502] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:62:0)
[10:25:43.502] Timer tick, asking Buildbucket for the build status
[10:25:43.583] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:43.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:63:0) after 1m0s
[10:26:43.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:63:0)
[10:26:43.650] Timer tick, asking Buildbucket for the build status
[10:26:43.738] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:43.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:64:0) after 1m0s
[10:27:43.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:64:0)
[10:27:43.797] Timer tick, asking Buildbucket for the build status
[10:27:44.095] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:44.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:65:0) after 1m0s
[10:28:44.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:65:0)
[10:28:44.116] Timer tick, asking Buildbucket for the build status
[10:28:44.172] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:44.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:66:0) after 1m0s
[10:29:44.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:66:0)
[10:29:44.165] Timer tick, asking Buildbucket for the build status
[10:29:44.281] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:44.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:67:0) after 1m0s
[10:30:44.336] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:67:0)
[10:30:44.336] Timer tick, asking Buildbucket for the build status
[10:30:44.497] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:44.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:68:0) after 1m0s
[10:31:44.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:68:0)
[10:31:44.516] Timer tick, asking Buildbucket for the build status
[10:31:44.630] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:44.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:69:0) after 1m0s
[10:32:44.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:69:0)
[10:32:44.716] Timer tick, asking Buildbucket for the build status
[10:32:44.767] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:44.767] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:70:0) after 1m0s
[10:33:44.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:70:0)
[10:33:44.787] Timer tick, asking Buildbucket for the build status
[10:33:45.008] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:45.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:71:0) after 1m0s
[10:34:45.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:71:0)
[10:34:45.029] Timer tick, asking Buildbucket for the build status
[10:34:45.105] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:45.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:72:0) after 1m0s
[10:35:45.161] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:72:0)
[10:35:45.161] Timer tick, asking Buildbucket for the build status
[10:35:45.211] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:45.211] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:73:0) after 1m0s
[10:36:45.246] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:73:0)
[10:36:45.246] Timer tick, asking Buildbucket for the build status
[10:36:45.423] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:45.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:74:0) after 1m0s
[10:37:45.445] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:74:0)
[10:37:45.445] Timer tick, asking Buildbucket for the build status
[10:37:45.507] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:45.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:75:0) after 1m0s
[10:38:45.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:75:0)
[10:38:45.561] Timer tick, asking Buildbucket for the build status
[10:38:45.711] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:45.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:76:0) after 1m0s
[10:39:45.736] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:76:0)
[10:39:45.736] Timer tick, asking Buildbucket for the build status
[10:39:46.093] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:46.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:77:0) after 1m0s
[10:40:46.118] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:77:0)
[10:40:46.118] Timer tick, asking Buildbucket for the build status
[10:40:46.324] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:46.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:78:0) after 1m0s
[10:41:46.370] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:78:0)
[10:41:46.370] Timer tick, asking Buildbucket for the build status
[10:41:46.527] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:46.527] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:79:0) after 1m0s
[10:42:46.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:79:0)
[10:42:46.559] Timer tick, asking Buildbucket for the build status
[10:42:46.916] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:46.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:80:0) after 1m0s
[10:43:46.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:80:0)
[10:43:46.991] Timer tick, asking Buildbucket for the build status
[10:43:47.293] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:47.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:81:0) after 1m0s
[10:44:47.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:81:0)
[10:44:47.350] Timer tick, asking Buildbucket for the build status
[10:44:47.412] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:47.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:82:0) after 1m0s
[10:45:47.440] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:82:0)
[10:45:47.440] Timer tick, asking Buildbucket for the build status
[10:45:47.592] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:47.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:83:0) after 1m0s
[10:46:47.614] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:83:0)
[10:46:47.614] Timer tick, asking Buildbucket for the build status
[10:46:47.711] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:47.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:84:0) after 1m0s
[10:47:50.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:84:0)
[10:47:50.589] Timer tick, asking Buildbucket for the build status
[10:47:50.654] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:50.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:85:0) after 1m0s
[10:48:50.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:85:0)
[10:48:50.673] Timer tick, asking Buildbucket for the build status
[10:48:50.730] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:50.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:86:0) after 1m0s
[10:49:50.789] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:86:0)
[10:49:50.789] Timer tick, asking Buildbucket for the build status
[10:49:50.991] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:50.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:87:0) after 1m0s
[10:50:51.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:87:0)
[10:50:51.014] Timer tick, asking Buildbucket for the build status
[10:50:51.080] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:51.080] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:88:0) after 1m0s
[10:51:51.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:88:0)
[10:51:51.087] Timer tick, asking Buildbucket for the build status
[10:51:51.224] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:51.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:89:0) after 1m0s
[10:52:51.254] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:89:0)
[10:52:51.254] Timer tick, asking Buildbucket for the build status
[10:52:51.307] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:51.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:90:0) after 1m0s
[10:53:51.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:90:0)
[10:53:51.299] Timer tick, asking Buildbucket for the build status
[10:53:51.391] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:51.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:91:0) after 1m0s
[10:54:51.479] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:91:0)
[10:54:51.479] Timer tick, asking Buildbucket for the build status
[10:54:51.789] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:51.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:92:0) after 1m0s
[10:55:51.811] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:92:0)
[10:55:51.811] Timer tick, asking Buildbucket for the build status
[10:55:52.337] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:52.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:93:0) after 1m0s
[10:56:52.363] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:93:0)
[10:56:52.363] Timer tick, asking Buildbucket for the build status
[10:56:52.455] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:52.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:94:0) after 1m0s
[10:57:52.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:94:0)
[10:57:52.568] Timer tick, asking Buildbucket for the build status
[10:57:52.811] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:52.811] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:95:0) after 1m0s
[10:58:53.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:95:0)
[10:58:53.056] Timer tick, asking Buildbucket for the build status
[10:58:53.304] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:53.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:96:0) after 1m0s
[10:59:53.331] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:96:0)
[10:59:53.331] Timer tick, asking Buildbucket for the build status
[10:59:53.426] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:53.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:97:0) after 1m0s
[11:00:53.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:97:0)
[11:00:53.515] Timer tick, asking Buildbucket for the build status
[11:00:53.705] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:53.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:98:0) after 1m0s
[11:01:53.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:98:0)
[11:01:53.851] Timer tick, asking Buildbucket for the build status
[11:01:54.024] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:54.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:99:0) after 1m0s
[11:02:54.104] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:99:0)
[11:02:54.104] Timer tick, asking Buildbucket for the build status
[11:02:54.223] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:54.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:100:0) after 1m0s
[11:03:54.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:100:0)
[11:03:54.357] Timer tick, asking Buildbucket for the build status
[11:03:54.424] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:54.424] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:101:0) after 1m0s
[11:04:54.491] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:101:0)
[11:04:54.491] Timer tick, asking Buildbucket for the build status
[11:04:54.549] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:54.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:102:0) after 1m0s
[11:05:54.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:102:0)
[11:05:54.641] Timer tick, asking Buildbucket for the build status
[11:05:54.786] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:54.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:103:0) after 1m0s
[11:06:54.894] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:103:0)
[11:06:54.894] Timer tick, asking Buildbucket for the build status
[11:06:55.018] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:55.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:104:0) after 1m0s
[11:07:55.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:104:0)
[11:07:55.099] Timer tick, asking Buildbucket for the build status
[11:07:55.176] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:55.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:105:0) after 1m0s
[11:08:55.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:105:0)
[11:08:55.238] Timer tick, asking Buildbucket for the build status
[11:08:55.324] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:55.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:106:0) after 1m0s
[11:09:55.346] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:106:0)
[11:09:55.346] Timer tick, asking Buildbucket for the build status
[11:09:55.765] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:55.765] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:107:0) after 1m0s
[11:10:55.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:107:0)
[11:10:55.804] Timer tick, asking Buildbucket for the build status
[11:10:55.878] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:55.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:108:0) after 1m0s
[11:11:56.113] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:108:0)
[11:11:56.113] Timer tick, asking Buildbucket for the build status
[11:11:56.273] Build 8859680237189367376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:56.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9025110299104612832:109:0) after 1m0s
[11:12:27.568] Received PubSub notification, asking Buildbucket for the build status
[11:12:27.616] Build 8859680237189367376: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:12:27.616] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609153947022223",
"created_by": "project:chromium",
"created_ts": "1609147528428419",
"id": "8859680237189367376",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3e6cdd251797b1f3ce80f88d84fdd4f94c3e8079\"}}",
"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\": \"3e6cdd251797b1f3ce80f88d84fdd4f94c3e8079\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-72-tuo1\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Linux Viz\", \"buildnumber\": 25581, \"got_angle_revision\": \"5e606e5bfce2b23c139c5289cbf1299844fa4b43\", \"got_dawn_revision\": \"c8d5277e86ee8c51b1dd7892b41e83eb26ac2ede\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"3e6cdd251797b1f3ce80f88d84fdd4f94c3e8079\", \"got_revision_cp\": \"refs/heads/master@{#839422}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"a29c88f51455adc968183aaddadaaac75965b421\", \"got_v8_revision_cp\": \"refs/heads/8.9.193@{#1}\", \"got_webrtc_revision\": \"b90546580ec3e8236225f39f9e5e5e7b7128c24b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32881}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-viz-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3e6cdd251797b1f3ce80f88d84fdd4f94c3e8079\", \"swarm_hashes_refs/heads/master(at){#839422}_without_patch\": {\"blink_web_tests\": \"4c55f7d10630e2f0da1ba4352fc21e613ccfe1ad\", \"browser_tests\": \"6ef94aca4c9a3179ce489bbe8a7e543a93bbf942\", \"content_browsertests\": \"99f508c1f27433af7a613bc59267011f3a877723\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-72-tuo1\"], \"image\": [\"chrome-xenial-20122000-38c59757d9b\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1609147862678792",
"status": "COMPLETED",
"status_changed_ts": "1609153947366089",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/25581",
"builder:Linux Viz",
"buildset:commit/git/3e6cdd251797b1f3ce80f88d84fdd4f94c3e8079",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3e6cdd251797b1f3ce80f88d84fdd4f94c3e8079",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025110299104612832",
"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/8859680237189367376/+/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:50c17d0b453c6e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1609153947369932",
"url": "https://ci.chromium.org/b/8859680237189367376",
"utcnow_ts": "1609153947610339"
}
}
[11:12:27.616] Invocation finished in 1h47m0.398169965s with status SUCCEEDED