[19:48:36.289] New invocation is queued and will start shortly
[19:48:37.829] Starting the invocation (attempt 1)
[19:48:37.863] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:48:37.863] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:48:37.863] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9042375114419984992",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4b330727af5ee9ca2e5ec154db005fd93b0001c3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9042375114419984992",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/4b330727af5ee9ca2e5ec154db005fd93b0001c3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4b330727af5ee9ca2e5ec154db005fd93b0001c3",
"gitiles_ref:refs/heads/master"
]
}
[19:48:39.902] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1592682518671374",
"id": "8876945051260286992",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4b330727af5ee9ca2e5ec154db005fd93b0001c3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1592682519634985",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/22659",
"builder:Linux Viz",
"buildset:commit/git/4b330727af5ee9ca2e5ec154db005fd93b0001c3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4b330727af5ee9ca2e5ec154db005fd93b0001c3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9042375114419984992",
"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/8876945051260286992/+/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": "1592682519635119",
"url": "https://ci.chromium.org/b/8876945051260286992",
"utcnow_ts": "1592682519838811"
}
}
[19:48:39.902] Task URL: https://ci.chromium.org/b/8876945051260286992
[19:48:39.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:2:0) after 1m0s
[19:49:39.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:2:0)
[19:49:39.918] Timer tick, asking Buildbucket for the build status
[19:49:40.037] Build 8876945051260286992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:40.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:3:0) after 1m0s
[19:50:40.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:3:0)
[19:50:40.014] Timer tick, asking Buildbucket for the build status
[19:50:40.170] Build 8876945051260286992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:50:40.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:4:0) after 1m0s
[19:51:40.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:4:0)
[19:51:40.199] Timer tick, asking Buildbucket for the build status
[19:51:40.390] Build 8876945051260286992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:51:40.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:5:0) after 1m0s
[19:52:40.425] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:5:0)
[19:52:40.425] Timer tick, asking Buildbucket for the build status
[19:52:40.663] Build 8876945051260286992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:40.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:6:0) after 1m0s
[19:53:40.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:6:0)
[19:53:40.729] Timer tick, asking Buildbucket for the build status
[19:53:43.988] Build 8876945051260286992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:43.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:7:0) after 1m0s
[19:54:44.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:7:0)
[19:54:44.015] Timer tick, asking Buildbucket for the build status
[19:54:44.133] Build 8876945051260286992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:44.133] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:8:0) after 1m0s
[19:55:44.155] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:8:0)
[19:55:44.155] Timer tick, asking Buildbucket for the build status
[19:55:44.277] Build 8876945051260286992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:44.277] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:9:0) after 1m0s
[19:56:44.288] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:9:0)
[19:56:44.288] Timer tick, asking Buildbucket for the build status
[19:56:44.461] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:44.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:10:0) after 1m0s
[19:56:46.394] Received PubSub notification, asking Buildbucket for the build status
[19:56:46.522] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:44.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:10:0)
[19:57:44.550] Timer tick, asking Buildbucket for the build status
[19:57:44.669] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:44.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:12:0) after 1m0s
[19:58:44.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:12:0)
[19:58:44.691] Timer tick, asking Buildbucket for the build status
[19:58:44.851] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:44.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:13:0) after 1m0s
[19:59:44.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:13:0)
[19:59:44.923] Timer tick, asking Buildbucket for the build status
[19:59:45.090] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:45.090] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:14:0) after 1m0s
[20:00:45.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:14:0)
[20:00:45.108] Timer tick, asking Buildbucket for the build status
[20:00:45.269] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:45.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:15:0) after 1m0s
[20:01:45.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:15:0)
[20:01:45.293] Timer tick, asking Buildbucket for the build status
[20:01:45.427] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:45.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:16:0) after 1m0s
[20:02:45.457] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:16:0)
[20:02:45.457] Timer tick, asking Buildbucket for the build status
[20:02:45.568] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:45.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:17:0) after 1m0s
[20:03:45.586] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:17:0)
[20:03:45.586] Timer tick, asking Buildbucket for the build status
[20:03:45.782] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:45.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:18:0) after 1m0s
[20:04:45.817] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:18:0)
[20:04:45.817] Timer tick, asking Buildbucket for the build status
[20:04:45.936] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:45.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:19:0) after 1m0s
[20:05:45.984] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:19:0)
[20:05:45.984] Timer tick, asking Buildbucket for the build status
[20:05:46.222] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:46.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:20:0) after 1m0s
[20:06:46.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:20:0)
[20:06:46.241] Timer tick, asking Buildbucket for the build status
[20:06:46.451] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:46.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:21:0) after 1m0s
[20:07:46.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:21:0)
[20:07:46.483] Timer tick, asking Buildbucket for the build status
[20:07:46.605] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:46.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:22:0) after 1m0s
[20:08:46.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:22:0)
[20:08:46.685] Timer tick, asking Buildbucket for the build status
[20:08:46.893] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:46.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:23:0) after 1m0s
[20:09:46.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:23:0)
[20:09:46.927] Timer tick, asking Buildbucket for the build status
[20:09:47.072] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:47.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:24:0) after 1m0s
[20:10:47.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:24:0)
[20:10:47.124] Timer tick, asking Buildbucket for the build status
[20:10:47.268] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:47.268] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:25:0) after 1m0s
[20:11:47.382] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:25:0)
[20:11:47.382] Timer tick, asking Buildbucket for the build status
[20:11:47.559] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:47.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:26:0) after 1m0s
[20:12:47.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:26:0)
[20:12:47.534] Timer tick, asking Buildbucket for the build status
[20:12:47.774] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:47.774] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:27:0) after 1m0s
[20:13:47.819] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:27:0)
[20:13:47.819] Timer tick, asking Buildbucket for the build status
[20:13:48.045] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:48.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:28:0) after 1m0s
[20:14:48.104] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:28:0)
[20:14:48.104] Timer tick, asking Buildbucket for the build status
[20:14:48.321] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:48.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:29:0) after 1m0s
[20:15:48.361] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:29:0)
[20:15:48.361] Timer tick, asking Buildbucket for the build status
[20:15:48.551] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:48.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:30:0) after 1m0s
[20:16:48.618] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:30:0)
[20:16:48.618] Timer tick, asking Buildbucket for the build status
[20:16:48.837] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:48.837] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:31:0) after 1m0s
[20:17:48.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:31:0)
[20:17:48.859] Timer tick, asking Buildbucket for the build status
[20:17:48.974] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:48.974] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:32:0) after 1m0s
[20:18:48.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:32:0)
[20:18:48.991] Timer tick, asking Buildbucket for the build status
[20:18:50.234] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:50.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:33:0) after 1m0s
[20:19:50.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:33:0)
[20:19:50.268] Timer tick, asking Buildbucket for the build status
[20:19:50.420] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:50.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:34:0) after 1m0s
[20:20:50.444] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:34:0)
[20:20:50.444] Timer tick, asking Buildbucket for the build status
[20:20:50.612] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:50.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:35:0) after 1m0s
[20:21:50.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:35:0)
[20:21:50.630] Timer tick, asking Buildbucket for the build status
[20:21:50.761] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:50.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:36:0) after 1m0s
[20:22:50.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:36:0)
[20:22:50.824] Timer tick, asking Buildbucket for the build status
[20:22:51.145] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:51.145] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:37:0) after 1m0s
[20:23:51.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:37:0)
[20:23:51.199] Timer tick, asking Buildbucket for the build status
[20:23:52.440] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:52.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:38:0) after 1m0s
[20:24:52.440] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:38:0)
[20:24:52.440] Timer tick, asking Buildbucket for the build status
[20:24:52.727] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:52.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:39:0) after 1m0s
[20:25:52.776] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:39:0)
[20:25:52.776] Timer tick, asking Buildbucket for the build status
[20:25:52.913] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:52.913] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:40:0) after 1m0s
[20:26:52.949] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:40:0)
[20:26:52.949] Timer tick, asking Buildbucket for the build status
[20:26:53.144] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:53.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:41:0) after 1m0s
[20:27:53.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:41:0)
[20:27:53.187] Timer tick, asking Buildbucket for the build status
[20:27:53.355] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:53.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:42:0) after 1m0s
[20:28:53.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:42:0)
[20:28:53.428] Timer tick, asking Buildbucket for the build status
[20:28:53.734] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:53.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:43:0) after 1m0s
[20:29:53.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:43:0)
[20:29:53.931] Timer tick, asking Buildbucket for the build status
[20:29:54.036] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:54.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:44:0) after 1m0s
[20:30:54.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:44:0)
[20:30:54.105] Timer tick, asking Buildbucket for the build status
[20:30:54.206] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:54.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:45:0) after 1m0s
[20:31:54.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:45:0)
[20:31:54.238] Timer tick, asking Buildbucket for the build status
[20:31:54.680] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:54.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:46:0) after 1m0s
[20:32:54.713] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:46:0)
[20:32:54.713] Timer tick, asking Buildbucket for the build status
[20:32:55.032] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:55.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:47:0) after 1m0s
[20:33:55.114] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:47:0)
[20:33:55.114] Timer tick, asking Buildbucket for the build status
[20:33:55.671] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:55.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:48:0) after 1m0s
[20:34:55.780] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:48:0)
[20:34:55.780] Timer tick, asking Buildbucket for the build status
[20:34:55.895] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:55.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:49:0) after 1m0s
[20:35:55.912] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:49:0)
[20:35:55.912] Timer tick, asking Buildbucket for the build status
[20:35:56.199] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:56.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:50:0) after 1m0s
[20:36:56.356] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:50:0)
[20:36:56.356] Timer tick, asking Buildbucket for the build status
[20:36:56.517] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:56.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:51:0) after 1m0s
[20:37:56.543] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:51:0)
[20:37:56.543] Timer tick, asking Buildbucket for the build status
[20:37:56.738] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:56.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:52:0) after 1m0s
[20:38:56.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:52:0)
[20:38:56.774] Timer tick, asking Buildbucket for the build status
[20:38:56.921] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:56.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:53:0) after 1m0s
[20:39:56.945] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:53:0)
[20:39:56.945] Timer tick, asking Buildbucket for the build status
[20:39:57.132] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:57.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:54:0) after 1m0s
[20:40:57.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:54:0)
[20:40:57.157] Timer tick, asking Buildbucket for the build status
[20:40:57.284] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:57.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:55:0) after 1m0s
[20:41:57.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:55:0)
[20:41:57.368] Timer tick, asking Buildbucket for the build status
[20:41:57.481] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:57.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:56:0) after 1m0s
[20:42:57.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:56:0)
[20:42:57.598] Timer tick, asking Buildbucket for the build status
[20:42:57.749] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:57.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:57:0) after 1m0s
[20:43:57.920] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:57:0)
[20:43:57.920] Timer tick, asking Buildbucket for the build status
[20:43:58.082] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:58.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:58:0) after 1m0s
[20:44:58.161] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:58:0)
[20:44:58.161] Timer tick, asking Buildbucket for the build status
[20:44:58.287] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:58.287] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:59:0) after 1m0s
[20:45:58.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:59:0)
[20:45:58.337] Timer tick, asking Buildbucket for the build status
[20:45:58.877] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:58.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:60:0) after 1m0s
[20:46:58.960] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:60:0)
[20:46:58.960] Timer tick, asking Buildbucket for the build status
[20:46:59.465] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:59.465] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:61:0) after 1m0s
[20:47:59.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:61:0)
[20:47:59.534] Timer tick, asking Buildbucket for the build status
[20:48:00.272] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:00.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:62:0) after 1m0s
[20:49:00.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:62:0)
[20:49:00.292] Timer tick, asking Buildbucket for the build status
[20:49:00.550] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:00.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:63:0) after 1m0s
[20:50:00.588] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:63:0)
[20:50:00.588] Timer tick, asking Buildbucket for the build status
[20:50:00.740] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:00.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:64:0) after 1m0s
[20:51:01.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:64:0)
[20:51:01.116] Timer tick, asking Buildbucket for the build status
[20:51:01.463] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:01.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:65:0) after 1m0s
[20:52:01.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:65:0)
[20:52:01.792] Timer tick, asking Buildbucket for the build status
[20:52:02.094] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:02.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:66:0) after 1m0s
[20:53:02.254] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:66:0)
[20:53:02.254] Timer tick, asking Buildbucket for the build status
[20:53:02.380] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:02.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:67:0) after 1m0s
[20:54:03.585] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:67:0)
[20:54:03.585] Timer tick, asking Buildbucket for the build status
[20:54:03.954] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:03.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:68:0) after 1m0s
[20:55:04.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:68:0)
[20:55:04.524] Timer tick, asking Buildbucket for the build status
[20:55:04.640] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:04.640] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:69:0) after 1m0s
[20:56:04.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:69:0)
[20:56:04.950] Timer tick, asking Buildbucket for the build status
[20:56:05.052] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:05.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:70:0) after 1m0s
[20:57:05.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:70:0)
[20:57:05.212] Timer tick, asking Buildbucket for the build status
[20:57:05.589] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:05.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:71:0) after 1m0s
[20:58:05.697] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:71:0)
[20:58:05.697] Timer tick, asking Buildbucket for the build status
[20:58:05.832] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:05.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:72:0) after 1m0s
[20:59:06.006] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:72:0)
[20:59:06.006] Timer tick, asking Buildbucket for the build status
[20:59:06.138] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:06.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:73:0) after 1m0s
[21:00:06.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:73:0)
[21:00:06.366] Timer tick, asking Buildbucket for the build status
[21:00:08.730] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:08.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:74:0) after 1m0s
[21:01:08.997] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:74:0)
[21:01:08.997] Timer tick, asking Buildbucket for the build status
[21:01:09.669] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:09.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:75:0) after 1m0s
[21:02:09.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:75:0)
[21:02:09.948] Timer tick, asking Buildbucket for the build status
[21:02:10.935] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:10.935] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:76:0) after 1m0s
[21:03:11.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:76:0)
[21:03:11.074] Timer tick, asking Buildbucket for the build status
[21:03:11.734] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:11.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:77:0) after 1m0s
[21:04:11.772] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:77:0)
[21:04:11.772] Timer tick, asking Buildbucket for the build status
[21:04:11.949] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:11.949] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:78:0) after 1m0s
[21:05:12.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:78:0)
[21:05:12.032] Timer tick, asking Buildbucket for the build status
[21:05:12.902] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:12.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:79:0) after 1m0s
[21:06:12.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:79:0)
[21:06:12.924] Timer tick, asking Buildbucket for the build status
[21:06:13.054] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:13.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:80:0) after 1m0s
[21:07:13.079] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:80:0)
[21:07:13.079] Timer tick, asking Buildbucket for the build status
[21:07:13.202] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:13.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:81:0) after 1m0s
[21:08:13.237] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:81:0)
[21:08:13.237] Timer tick, asking Buildbucket for the build status
[21:08:13.509] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:13.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:82:0) after 1m0s
[21:09:13.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:82:0)
[21:09:13.535] Timer tick, asking Buildbucket for the build status
[21:09:16.832] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:16.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:83:0) after 1m0s
[21:10:16.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:83:0)
[21:10:16.859] Timer tick, asking Buildbucket for the build status
[21:10:17.067] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:17.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:84:0) after 1m0s
[21:11:17.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:84:0)
[21:11:17.143] Timer tick, asking Buildbucket for the build status
[21:11:17.451] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:17.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:85:0) after 1m0s
[21:12:17.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:85:0)
[21:12:17.488] Timer tick, asking Buildbucket for the build status
[21:12:19.558] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:19.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:86:0) after 1m0s
[21:13:19.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:86:0)
[21:13:19.608] Timer tick, asking Buildbucket for the build status
[21:13:19.783] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:19.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:87:0) after 1m0s
[21:14:19.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:87:0)
[21:14:19.803] Timer tick, asking Buildbucket for the build status
[21:14:19.929] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:19.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:88:0) after 1m0s
[21:15:19.953] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:88:0)
[21:15:19.953] Timer tick, asking Buildbucket for the build status
[21:15:20.453] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:20.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:89:0) after 1m0s
[21:16:20.478] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:89:0)
[21:16:20.478] Timer tick, asking Buildbucket for the build status
[21:16:20.653] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:20.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:90:0) after 1m0s
[21:17:20.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:90:0)
[21:17:20.705] Timer tick, asking Buildbucket for the build status
[21:17:20.959] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:20.959] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:91:0) after 1m0s
[21:18:20.982] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:91:0)
[21:18:20.982] Timer tick, asking Buildbucket for the build status
[21:18:21.207] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:21.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:92:0) after 1m0s
[21:19:21.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:92:0)
[21:19:21.381] Timer tick, asking Buildbucket for the build status
[21:19:21.616] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:21.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:93:0) after 1m0s
[21:20:21.653] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:93:0)
[21:20:21.653] Timer tick, asking Buildbucket for the build status
[21:20:21.920] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:21.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:94:0) after 1m0s
[21:21:22.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:94:0)
[21:21:22.001] Timer tick, asking Buildbucket for the build status
[21:21:22.216] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:22.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:95:0) after 1m0s
[21:22:22.206] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:95:0)
[21:22:22.206] Timer tick, asking Buildbucket for the build status
[21:22:22.381] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:22.381] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:96:0) after 1m0s
[21:23:22.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:96:0)
[21:23:22.401] Timer tick, asking Buildbucket for the build status
[21:23:22.693] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:22.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:97:0) after 1m0s
[21:24:22.769] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:97:0)
[21:24:22.769] Timer tick, asking Buildbucket for the build status
[21:24:22.899] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:22.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:98:0) after 1m0s
[21:25:22.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:98:0)
[21:25:22.933] Timer tick, asking Buildbucket for the build status
[21:25:23.245] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:23.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:99:0) after 1m0s
[21:26:23.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:99:0)
[21:26:23.287] Timer tick, asking Buildbucket for the build status
[21:26:23.799] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:23.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:100:0) after 1m0s
[21:27:23.887] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:100:0)
[21:27:23.887] Timer tick, asking Buildbucket for the build status
[21:27:24.268] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:24.268] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:101:0) after 1m0s
[21:28:24.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:101:0)
[21:28:24.281] Timer tick, asking Buildbucket for the build status
[21:28:24.657] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:24.658] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:102:0) after 1m0s
[21:29:24.660] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:102:0)
[21:29:24.660] Timer tick, asking Buildbucket for the build status
[21:29:24.964] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:24.964] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:103:0) after 1m0s
[21:30:24.964] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:103:0)
[21:30:24.964] Timer tick, asking Buildbucket for the build status
[21:30:25.140] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:25.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:104:0) after 1m0s
[21:31:25.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:104:0)
[21:31:25.262] Timer tick, asking Buildbucket for the build status
[21:31:25.383] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:25.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:105:0) after 1m0s
[21:32:25.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:105:0)
[21:32:25.405] Timer tick, asking Buildbucket for the build status
[21:32:25.549] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:25.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:106:0) after 1m0s
[21:33:25.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:106:0)
[21:33:25.575] Timer tick, asking Buildbucket for the build status
[21:33:25.739] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:25.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:107:0) after 1m0s
[21:34:25.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:107:0)
[21:34:25.759] Timer tick, asking Buildbucket for the build status
[21:34:25.874] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:25.874] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:108:0) after 1m0s
[21:35:25.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:108:0)
[21:35:25.979] Timer tick, asking Buildbucket for the build status
[21:35:26.145] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:26.145] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:109:0) after 1m0s
[21:36:26.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:109:0)
[21:36:26.221] Timer tick, asking Buildbucket for the build status
[21:36:26.325] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:26.325] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:110:0) after 1m0s
[21:37:26.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:110:0)
[21:37:26.368] Timer tick, asking Buildbucket for the build status
[21:37:26.706] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:26.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:111:0) after 1m0s
[21:38:26.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:111:0)
[21:38:26.744] Timer tick, asking Buildbucket for the build status
[21:38:26.897] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:26.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:112:0) after 1m0s
[21:39:26.934] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:112:0)
[21:39:26.934] Timer tick, asking Buildbucket for the build status
[21:39:27.074] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:27.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:113:0) after 1m0s
[21:40:27.322] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:113:0)
[21:40:27.322] Timer tick, asking Buildbucket for the build status
[21:40:27.452] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:27.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:114:0) after 1m0s
[21:41:27.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:114:0)
[21:41:27.569] Timer tick, asking Buildbucket for the build status
[21:41:27.696] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:27.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:115:0) after 1m0s
[21:42:27.841] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:115:0)
[21:42:27.841] Timer tick, asking Buildbucket for the build status
[21:42:27.972] Build 8876945051260286992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:27.972] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9042375114419984992:116:0) after 1m0s
[21:43:07.327] Received PubSub notification, asking Buildbucket for the build status
[21:43:07.553] Build 8876945051260286992: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:43:07.553] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1592689386580460",
"created_by": "project:chromium",
"created_ts": "1592682518671374",
"id": "8876945051260286992",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4b330727af5ee9ca2e5ec154db005fd93b0001c3\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-7-2vla\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Viz\", \"buildnumber\": 22659, \"got_angle_revision\": \"b772a955e70cee70b22c2170351476c7f865d577\", \"got_dawn_revision\": \"250f26229b27df7f19e013ca304843a666eb9f25\", \"got_nacl_revision\": \"87616f7ce2ea8383efd3731960c15f4ba5852d93\", \"got_revision\": \"4b330727af5ee9ca2e5ec154db005fd93b0001c3\", \"got_revision_cp\": \"refs/heads/master@{#780593}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"ae1007957f096d015a1d48697a75c78d75d2f7b2\", \"got_v8_revision\": \"92ef92314762433b372528e3590aa3dde31cb94f\", \"got_v8_revision_cp\": \"refs/heads/8.5.188@{#1}\", \"got_webrtc_revision\": \"7a82467d0db0d61f466a1da54b94f6a136726a3c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31546}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4b330727af5ee9ca2e5ec154db005fd93b0001c3\", \"swarm_hashes\": {\"blink_web_tests\": \"f0085a82e5aa7a3ad15af710730047391352f11a\", \"browser_tests\": \"d320a2c32015c87793f94fb5e0786a488bb43764\", \"content_browsertests\": \"1d5a716c8e2c40296710368290a53b0328135e52\"}, \"swarm_hashes_refs/heads/master(at){#780593}_without_patch\": {\"blink_web_tests\": \"f0085a82e5aa7a3ad15af710730047391352f11a\", \"browser_tests\": \"d320a2c32015c87793f94fb5e0786a488bb43764\", \"content_browsertests\": \"1d5a716c8e2c40296710368290a53b0328135e52\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1989594bdf03467d4cca251563547d36d290a477ee0cdac91b5f17239ddd8c8b_v2\", \"builder_3e75b41c9bcf12a22209c03b338cce1fafa12941d3074ed1e1ed2450e6b71594_v2\", \"builder_8116c80c2882afcd67a910417bbd6fba6f94de5911d922ccd599199b9d07f827_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_a10052c67097968898fa29710cdaa0ada58a120001760a536a006ca29eefe964_v2\", \"builder_ce52aa3ab9d9a450d9b5f3fb151dc5a055ee991845b7d9f6a360be4cd1eb07f1_v2\", \"builder_e5bbff72983945f6847543519ce1052420cedd06fb8495f4080bfa2e6bcfd13f_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-central1-b-8-7-2vla\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5218-123b763\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1592683003595444",
"status": "COMPLETED",
"status_changed_ts": "1592689386885348",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/22659",
"builder:Linux Viz",
"buildset:commit/git/4b330727af5ee9ca2e5ec154db005fd93b0001c3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4b330727af5ee9ca2e5ec154db005fd93b0001c3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9042375114419984992",
"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/8876945051260286992/+/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:4cec18260274d510",
"user_agent:luci-scheduler"
],
"updated_ts": "1592689386889989",
"url": "https://ci.chromium.org/b/8876945051260286992",
"utcnow_ts": "1592689387541192"
}
}
[21:43:07.553] Invocation finished in 1h54m31.278612155s with status SUCCEEDED