[13:38:14.832] New invocation is queued and will start shortly
[13:38:16.019] Starting the invocation (attempt 1)
[13:38:16.062] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:38:16.062] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:38:16.062] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031436182374854464",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f1e3e0264763a7deec1f0ef2f7d43be8b9c6160e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9031436182374854464",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/f1e3e0264763a7deec1f0ef2f7d43be8b9c6160e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f1e3e0264763a7deec1f0ef2f7d43be8b9c6160e",
"gitiles_ref:refs/heads/master"
]
}
[13:38:16.780] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603114696192115",
"id": "8866006120283801488",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f1e3e0264763a7deec1f0ef2f7d43be8b9c6160e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603114696551765",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/24371",
"builder:Linux Viz",
"buildset:commit/git/f1e3e0264763a7deec1f0ef2f7d43be8b9c6160e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f1e3e0264763a7deec1f0ef2f7d43be8b9c6160e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031436182374854464",
"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/8866006120283801488/+/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": "1603114696551874",
"url": "https://ci.chromium.org/b/8866006120283801488",
"utcnow_ts": "1603114696719578"
}
}
[13:38:16.780] Task URL: https://ci.chromium.org/b/8866006120283801488
[13:38:16.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:2:0) after 1m0s
[13:39:06.158] Received PubSub notification, asking Buildbucket for the build status
[13:39:06.235] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:16.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:2:0)
[13:39:16.868] Timer tick, asking Buildbucket for the build status
[13:39:16.948] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:16.948] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:4:0) after 1m0s
[13:40:17.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:4:0)
[13:40:17.003] Timer tick, asking Buildbucket for the build status
[13:40:17.509] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:17.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:5:0) after 1m0s
[13:41:17.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:5:0)
[13:41:17.546] Timer tick, asking Buildbucket for the build status
[13:41:17.611] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:17.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:6:0) after 1m0s
[13:42:17.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:6:0)
[13:42:17.700] Timer tick, asking Buildbucket for the build status
[13:42:17.801] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:17.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:7:0) after 1m0s
[13:43:17.901] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:7:0)
[13:43:17.902] Timer tick, asking Buildbucket for the build status
[13:43:17.988] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:17.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:8:0) after 1m0s
[13:44:18.017] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:8:0)
[13:44:18.017] Timer tick, asking Buildbucket for the build status
[13:44:18.126] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:18.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:9:0) after 1m0s
[13:45:18.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:9:0)
[13:45:18.194] Timer tick, asking Buildbucket for the build status
[13:45:18.296] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:18.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:10:0) after 1m0s
[13:46:18.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:10:0)
[13:46:18.323] Timer tick, asking Buildbucket for the build status
[13:46:18.399] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:18.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:11:0) after 1m0s
[13:47:18.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:11:0)
[13:47:18.434] Timer tick, asking Buildbucket for the build status
[13:47:18.528] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:18.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:12:0) after 1m0s
[13:48:18.547] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:12:0)
[13:48:18.547] Timer tick, asking Buildbucket for the build status
[13:48:18.672] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:18.672] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:13:0) after 1m0s
[13:49:18.745] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:13:0)
[13:49:18.745] Timer tick, asking Buildbucket for the build status
[13:49:18.990] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:18.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:14:0) after 1m0s
[13:50:19.047] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:14:0)
[13:50:19.047] Timer tick, asking Buildbucket for the build status
[13:50:19.182] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:19.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:15:0) after 1m0s
[13:51:19.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:15:0)
[13:51:19.233] Timer tick, asking Buildbucket for the build status
[13:51:19.302] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:19.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:16:0) after 1m0s
[13:52:19.430] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:16:0)
[13:52:19.430] Timer tick, asking Buildbucket for the build status
[13:52:19.503] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:19.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:17:0) after 1m0s
[13:53:19.533] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:17:0)
[13:53:19.533] Timer tick, asking Buildbucket for the build status
[13:53:20.111] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:20.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:18:0) after 1m0s
[13:54:20.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:18:0)
[13:54:20.228] Timer tick, asking Buildbucket for the build status
[13:54:20.303] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:20.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:19:0) after 1m0s
[13:55:20.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:19:0)
[13:55:20.414] Timer tick, asking Buildbucket for the build status
[13:55:20.595] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:20.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:20:0) after 1m0s
[13:56:20.684] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:20:0)
[13:56:20.684] Timer tick, asking Buildbucket for the build status
[13:56:20.822] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:20.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:21:0) after 1m0s
[13:57:20.818] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:21:0)
[13:57:20.818] Timer tick, asking Buildbucket for the build status
[13:57:21.004] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:21.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:22:0) after 1m0s
[13:58:21.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:22:0)
[13:58:21.073] Timer tick, asking Buildbucket for the build status
[13:58:21.180] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:21.180] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:23:0) after 1m0s
[13:59:21.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:23:0)
[13:59:21.229] Timer tick, asking Buildbucket for the build status
[13:59:21.340] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:21.340] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:24:0) after 1m0s
[14:00:21.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:24:0)
[14:00:21.561] Timer tick, asking Buildbucket for the build status
[14:00:21.652] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:21.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:25:0) after 1m0s
[14:01:21.754] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:25:0)
[14:01:21.754] Timer tick, asking Buildbucket for the build status
[14:01:21.815] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:21.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:26:0) after 1m0s
[14:02:21.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:26:0)
[14:02:21.884] Timer tick, asking Buildbucket for the build status
[14:02:21.946] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:21.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:27:0) after 1m0s
[14:03:21.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:27:0)
[14:03:21.974] Timer tick, asking Buildbucket for the build status
[14:03:22.097] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:22.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:28:0) after 1m0s
[14:04:22.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:28:0)
[14:04:22.116] Timer tick, asking Buildbucket for the build status
[14:04:22.176] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:22.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:29:0) after 1m0s
[14:05:22.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:29:0)
[14:05:22.231] Timer tick, asking Buildbucket for the build status
[14:05:22.317] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:22.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:30:0) after 1m0s
[14:06:22.433] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:30:0)
[14:06:22.433] Timer tick, asking Buildbucket for the build status
[14:06:22.510] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:22.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:31:0) after 1m0s
[14:07:22.595] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:31:0)
[14:07:22.595] Timer tick, asking Buildbucket for the build status
[14:07:22.703] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:22.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:32:0) after 1m0s
[14:08:22.882] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:32:0)
[14:08:22.882] Timer tick, asking Buildbucket for the build status
[14:08:23.025] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:23.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:33:0) after 1m0s
[14:09:23.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:33:0)
[14:09:23.137] Timer tick, asking Buildbucket for the build status
[14:09:23.206] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:23.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:34:0) after 1m0s
[14:10:23.580] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:34:0)
[14:10:23.580] Timer tick, asking Buildbucket for the build status
[14:10:23.691] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:23.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:35:0) after 1m0s
[14:11:23.874] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:35:0)
[14:11:23.874] Timer tick, asking Buildbucket for the build status
[14:11:23.948] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:23.948] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:36:0) after 1m0s
[14:12:24.145] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:36:0)
[14:12:24.145] Timer tick, asking Buildbucket for the build status
[14:12:24.210] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:24.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:37:0) after 1m0s
[14:13:24.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:37:0)
[14:13:24.307] Timer tick, asking Buildbucket for the build status
[14:13:24.421] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:24.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:38:0) after 1m0s
[14:14:24.438] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:38:0)
[14:14:24.438] Timer tick, asking Buildbucket for the build status
[14:14:24.508] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:24.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:39:0) after 1m0s
[14:15:24.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:39:0)
[14:15:24.626] Timer tick, asking Buildbucket for the build status
[14:15:24.681] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:24.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:40:0) after 1m0s
[14:16:24.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:40:0)
[14:16:24.779] Timer tick, asking Buildbucket for the build status
[14:16:24.852] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:24.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:41:0) after 1m0s
[14:17:24.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:41:0)
[14:17:24.935] Timer tick, asking Buildbucket for the build status
[14:17:25.127] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:25.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:42:0) after 1m0s
[14:18:25.222] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:42:0)
[14:18:25.222] Timer tick, asking Buildbucket for the build status
[14:18:25.379] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:25.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:43:0) after 1m0s
[14:19:25.508] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:43:0)
[14:19:25.508] Timer tick, asking Buildbucket for the build status
[14:19:25.566] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:25.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:44:0) after 1m0s
[14:20:25.676] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:44:0)
[14:20:25.676] Timer tick, asking Buildbucket for the build status
[14:20:25.915] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:25.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:45:0) after 1m0s
[14:21:26.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:45:0)
[14:21:26.053] Timer tick, asking Buildbucket for the build status
[14:21:26.128] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:26.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:46:0) after 1m0s
[14:22:26.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:46:0)
[14:22:26.147] Timer tick, asking Buildbucket for the build status
[14:22:26.217] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:26.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:47:0) after 1m0s
[14:23:26.310] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:47:0)
[14:23:26.310] Timer tick, asking Buildbucket for the build status
[14:23:26.491] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:26.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:48:0) after 1m0s
[14:24:26.501] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:48:0)
[14:24:26.501] Timer tick, asking Buildbucket for the build status
[14:24:26.686] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:26.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:49:0) after 1m0s
[14:25:26.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:49:0)
[14:25:26.726] Timer tick, asking Buildbucket for the build status
[14:25:26.892] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:26.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:50:0) after 1m0s
[14:26:27.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:50:0)
[14:26:27.000] Timer tick, asking Buildbucket for the build status
[14:26:27.582] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:27.582] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:51:0) after 1m0s
[14:27:27.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:51:0)
[14:27:27.729] Timer tick, asking Buildbucket for the build status
[14:27:27.808] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:27.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:52:0) after 1m0s
[14:28:27.896] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:52:0)
[14:28:27.896] Timer tick, asking Buildbucket for the build status
[14:28:28.007] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:28.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:53:0) after 1m0s
[14:29:28.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:53:0)
[14:29:28.025] Timer tick, asking Buildbucket for the build status
[14:29:28.089] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:28.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:54:0) after 1m0s
[14:30:28.223] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:54:0)
[14:30:28.223] Timer tick, asking Buildbucket for the build status
[14:30:28.279] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:28.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:55:0) after 1m0s
[14:31:28.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:55:0)
[14:31:28.283] Timer tick, asking Buildbucket for the build status
[14:31:28.502] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:28.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:56:0) after 1m0s
[14:32:28.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:56:0)
[14:32:28.561] Timer tick, asking Buildbucket for the build status
[14:32:28.639] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:28.639] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:57:0) after 1m0s
[14:33:28.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:57:0)
[14:33:28.663] Timer tick, asking Buildbucket for the build status
[14:33:28.777] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:28.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:58:0) after 1m0s
[14:34:28.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:58:0)
[14:34:28.822] Timer tick, asking Buildbucket for the build status
[14:34:28.929] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:28.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:59:0) after 1m0s
[14:35:28.922] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:59:0)
[14:35:28.922] Timer tick, asking Buildbucket for the build status
[14:35:28.989] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:28.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:60:0) after 1m0s
[14:36:29.086] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:60:0)
[14:36:29.086] Timer tick, asking Buildbucket for the build status
[14:36:29.201] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:29.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:61:0) after 1m0s
[14:37:29.236] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:61:0)
[14:37:29.236] Timer tick, asking Buildbucket for the build status
[14:37:29.302] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:29.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:62:0) after 1m0s
[14:38:29.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:62:0)
[14:38:29.432] Timer tick, asking Buildbucket for the build status
[14:38:29.846] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:29.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:63:0) after 1m0s
[14:39:29.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:63:0)
[14:39:29.871] Timer tick, asking Buildbucket for the build status
[14:39:29.982] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:29.982] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:64:0) after 1m0s
[14:40:30.009] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:64:0)
[14:40:30.009] Timer tick, asking Buildbucket for the build status
[14:40:30.146] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:30.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:65:0) after 1m0s
[14:41:30.174] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:65:0)
[14:41:30.174] Timer tick, asking Buildbucket for the build status
[14:41:30.242] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:30.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:66:0) after 1m0s
[14:42:30.305] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:66:0)
[14:42:30.305] Timer tick, asking Buildbucket for the build status
[14:42:30.419] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:30.419] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:67:0) after 1m0s
[14:43:30.491] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:67:0)
[14:43:30.491] Timer tick, asking Buildbucket for the build status
[14:43:30.715] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:30.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:68:0) after 1m0s
[14:44:30.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:68:0)
[14:44:30.807] Timer tick, asking Buildbucket for the build status
[14:44:30.873] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:30.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:69:0) after 1m0s
[14:45:30.947] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:69:0)
[14:45:30.948] Timer tick, asking Buildbucket for the build status
[14:45:31.269] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:31.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:70:0) after 1m0s
[14:46:31.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:70:0)
[14:46:31.302] Timer tick, asking Buildbucket for the build status
[14:46:33.111] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:33.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:71:0) after 1m0s
[14:47:33.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:71:0)
[14:47:33.166] Timer tick, asking Buildbucket for the build status
[14:47:33.378] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:33.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:72:0) after 1m0s
[14:48:33.402] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:72:0)
[14:48:33.402] Timer tick, asking Buildbucket for the build status
[14:48:34.185] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:34.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:73:0) after 1m0s
[14:49:34.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:73:0)
[14:49:34.393] Timer tick, asking Buildbucket for the build status
[14:49:34.475] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:34.475] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:74:0) after 1m0s
[14:50:34.467] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:74:0)
[14:50:34.467] Timer tick, asking Buildbucket for the build status
[14:50:34.534] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:34.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:75:0) after 1m0s
[14:51:34.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:75:0)
[14:51:34.619] Timer tick, asking Buildbucket for the build status
[14:51:34.692] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:34.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:76:0) after 1m0s
[14:52:34.712] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:76:0)
[14:52:34.712] Timer tick, asking Buildbucket for the build status
[14:52:34.917] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:34.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:77:0) after 1m0s
[14:53:35.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:77:0)
[14:53:35.012] Timer tick, asking Buildbucket for the build status
[14:53:35.134] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:35.134] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:78:0) after 1m0s
[14:54:35.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:78:0)
[14:54:35.157] Timer tick, asking Buildbucket for the build status
[14:54:35.228] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:35.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:79:0) after 1m0s
[14:55:35.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:79:0)
[14:55:35.257] Timer tick, asking Buildbucket for the build status
[14:55:35.336] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:35.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:80:0) after 1m0s
[14:56:35.398] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:80:0)
[14:56:35.398] Timer tick, asking Buildbucket for the build status
[14:56:35.462] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:35.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:81:0) after 1m0s
[14:57:35.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:81:0)
[14:57:35.483] Timer tick, asking Buildbucket for the build status
[14:57:35.619] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:35.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:82:0) after 1m0s
[14:58:35.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:82:0)
[14:58:35.615] Timer tick, asking Buildbucket for the build status
[14:58:35.895] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:35.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:83:0) after 1m0s
[14:59:35.947] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:83:0)
[14:59:35.947] Timer tick, asking Buildbucket for the build status
[14:59:36.039] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:36.039] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:84:0) after 1m0s
[15:00:36.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:84:0)
[15:00:36.082] Timer tick, asking Buildbucket for the build status
[15:00:37.093] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:37.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:85:0) after 1m0s
[15:01:37.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:85:0)
[15:01:37.117] Timer tick, asking Buildbucket for the build status
[15:01:37.184] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:37.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:86:0) after 1m0s
[15:02:37.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:86:0)
[15:02:37.213] Timer tick, asking Buildbucket for the build status
[15:02:37.304] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:37.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:87:0) after 1m0s
[15:03:37.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:87:0)
[15:03:37.334] Timer tick, asking Buildbucket for the build status
[15:03:37.467] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:37.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:88:0) after 1m0s
[15:04:37.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:88:0)
[15:04:37.506] Timer tick, asking Buildbucket for the build status
[15:04:37.576] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:37.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:89:0) after 1m0s
[15:05:37.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:89:0)
[15:05:37.679] Timer tick, asking Buildbucket for the build status
[15:05:37.806] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:37.806] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:90:0) after 1m0s
[15:06:37.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:90:0)
[15:06:37.837] Timer tick, asking Buildbucket for the build status
[15:06:37.919] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:37.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:91:0) after 1m0s
[15:07:37.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:91:0)
[15:07:37.950] Timer tick, asking Buildbucket for the build status
[15:07:38.063] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:38.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:92:0) after 1m0s
[15:08:38.174] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:92:0)
[15:08:38.174] Timer tick, asking Buildbucket for the build status
[15:08:38.305] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:38.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:93:0) after 1m0s
[15:09:38.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:93:0)
[15:09:38.409] Timer tick, asking Buildbucket for the build status
[15:09:38.477] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:38.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:94:0) after 1m0s
[15:10:38.605] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:94:0)
[15:10:38.605] Timer tick, asking Buildbucket for the build status
[15:10:38.668] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:38.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:95:0) after 1m0s
[15:11:38.841] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:95:0)
[15:11:38.841] Timer tick, asking Buildbucket for the build status
[15:11:38.900] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:38.900] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:96:0) after 1m0s
[15:12:38.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:96:0)
[15:12:38.981] Timer tick, asking Buildbucket for the build status
[15:12:39.067] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:39.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:97:0) after 1m0s
[15:13:39.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:97:0)
[15:13:39.101] Timer tick, asking Buildbucket for the build status
[15:13:39.208] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:39.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:98:0) after 1m0s
[15:14:39.308] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:98:0)
[15:14:39.308] Timer tick, asking Buildbucket for the build status
[15:14:39.370] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:39.370] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:99:0) after 1m0s
[15:15:39.435] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:99:0)
[15:15:39.435] Timer tick, asking Buildbucket for the build status
[15:15:39.494] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:39.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:100:0) after 1m0s
[15:16:39.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:100:0)
[15:16:39.535] Timer tick, asking Buildbucket for the build status
[15:16:39.815] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:39.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:101:0) after 1m0s
[15:17:39.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:101:0)
[15:17:39.878] Timer tick, asking Buildbucket for the build status
[15:17:39.931] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:39.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:102:0) after 1m0s
[15:18:40.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:102:0)
[15:18:40.003] Timer tick, asking Buildbucket for the build status
[15:18:40.158] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:40.158] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:103:0) after 1m0s
[15:19:40.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:103:0)
[15:19:40.207] Timer tick, asking Buildbucket for the build status
[15:19:40.422] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:40.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:104:0) after 1m0s
[15:20:40.515] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:104:0)
[15:20:40.515] Timer tick, asking Buildbucket for the build status
[15:20:40.599] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:40.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:105:0) after 1m0s
[15:21:40.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:105:0)
[15:21:40.621] Timer tick, asking Buildbucket for the build status
[15:21:40.928] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:40.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:106:0) after 1m0s
[15:22:40.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:106:0)
[15:22:40.990] Timer tick, asking Buildbucket for the build status
[15:22:41.109] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:41.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:107:0) after 1m0s
[15:23:41.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:107:0)
[15:23:41.142] Timer tick, asking Buildbucket for the build status
[15:23:43.704] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:43.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:108:0) after 1m0s
[15:24:43.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:108:0)
[15:24:43.706] Timer tick, asking Buildbucket for the build status
[15:24:43.795] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:43.795] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:109:0) after 1m0s
[15:25:43.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:109:0)
[15:25:43.774] Timer tick, asking Buildbucket for the build status
[15:25:43.858] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:43.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:110:0) after 1m0s
[15:26:43.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:110:0)
[15:26:43.927] Timer tick, asking Buildbucket for the build status
[15:26:43.995] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:43.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:111:0) after 1m0s
[15:27:44.031] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:111:0)
[15:27:44.031] Timer tick, asking Buildbucket for the build status
[15:27:44.302] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:44.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:112:0) after 1m0s
[15:28:44.348] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:112:0)
[15:28:44.348] Timer tick, asking Buildbucket for the build status
[15:28:44.464] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:44.464] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:113:0) after 1m0s
[15:29:44.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:113:0)
[15:29:44.484] Timer tick, asking Buildbucket for the build status
[15:29:44.696] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:44.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:114:0) after 1m0s
[15:30:44.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:114:0)
[15:30:44.732] Timer tick, asking Buildbucket for the build status
[15:30:44.904] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:44.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:115:0) after 1m0s
[15:31:44.940] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:115:0)
[15:31:44.940] Timer tick, asking Buildbucket for the build status
[15:31:45.074] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:45.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:116:0) after 1m0s
[15:32:45.097] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:116:0)
[15:32:45.097] Timer tick, asking Buildbucket for the build status
[15:32:45.271] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:45.271] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:117:0) after 1m0s
[15:33:45.301] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:117:0)
[15:33:45.301] Timer tick, asking Buildbucket for the build status
[15:33:45.450] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:45.450] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:118:0) after 1m0s
[15:34:45.482] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:118:0)
[15:34:45.482] Timer tick, asking Buildbucket for the build status
[15:34:45.622] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:45.623] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:119:0) after 1m0s
[15:35:45.703] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:119:0)
[15:35:45.703] Timer tick, asking Buildbucket for the build status
[15:35:46.317] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:46.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:120:0) after 1m0s
[15:36:46.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:120:0)
[15:36:46.338] Timer tick, asking Buildbucket for the build status
[15:36:46.399] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:46.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:121:0) after 1m0s
[15:37:46.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:121:0)
[15:37:46.428] Timer tick, asking Buildbucket for the build status
[15:37:46.497] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:46.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:122:0) after 1m0s
[15:38:46.544] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:122:0)
[15:38:46.544] Timer tick, asking Buildbucket for the build status
[15:38:46.676] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:46.676] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:123:0) after 1m0s
[15:39:46.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:123:0)
[15:39:46.698] Timer tick, asking Buildbucket for the build status
[15:39:46.808] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:46.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:124:0) after 1m0s
[15:40:46.815] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:124:0)
[15:40:46.815] Timer tick, asking Buildbucket for the build status
[15:40:47.003] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:47.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:125:0) after 1m0s
[15:41:47.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:125:0)
[15:41:47.032] Timer tick, asking Buildbucket for the build status
[15:41:49.275] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:49.275] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:126:0) after 1m0s
[15:42:49.311] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:126:0)
[15:42:49.311] Timer tick, asking Buildbucket for the build status
[15:42:49.408] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:49.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:127:0) after 1m0s
[15:43:49.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:127:0)
[15:43:49.432] Timer tick, asking Buildbucket for the build status
[15:43:49.747] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:49.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:128:0) after 1m0s
[15:44:49.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:128:0)
[15:44:49.787] Timer tick, asking Buildbucket for the build status
[15:44:50.251] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:50.251] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:129:0) after 1m0s
[15:45:50.313] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:129:0)
[15:45:50.313] Timer tick, asking Buildbucket for the build status
[15:45:50.521] Build 8866006120283801488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:50.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9031436182374854464:130:0) after 1m0s
[15:45:54.856] Received PubSub notification, asking Buildbucket for the build status
[15:45:54.936] Build 8866006120283801488: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:45:54.936] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603122353606164",
"created_by": "project:chromium",
"created_ts": "1603114696192115",
"id": "8866006120283801488",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f1e3e0264763a7deec1f0ef2f7d43be8b9c6160e\"}}",
"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\": \"f1e3e0264763a7deec1f0ef2f7d43be8b9c6160e\", \"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-209-23wp\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Linux Viz\", \"buildnumber\": 24371, \"got_angle_revision\": \"e2e37e74709f3040494d0cbae16b0ccfe564881b\", \"got_dawn_revision\": \"875091308b04ba87e29c929ed707f27889c660ea\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"f1e3e0264763a7deec1f0ef2f7d43be8b9c6160e\", \"got_revision_cp\": \"refs/heads/master@{#818446}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"94e1f5b2bfe7f7fc8c2277d724a3b6ee8136bf19\", \"got_v8_revision_cp\": \"refs/heads/8.8.124@{#1}\", \"got_webrtc_revision\": \"1253aea08e5f78c455dd5e40a53ed2b6f72a98aa\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32432}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f1e3e0264763a7deec1f0ef2f7d43be8b9c6160e\", \"swarm_hashes_refs/heads/master(at){#818446}_without_patch\": {\"blink_web_tests\": \"27b2067d8b74f9c2c2af6ca12dbf4604ce55ea22\", \"browser_tests\": \"61c8484f31adbc630432ec95b53a706ec16800cf\", \"content_browsertests\": \"b6ed784476f3340f7892f503a0acf838da324639\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_5e40e9df3c25d6ec04b042625e64587de25b7cc9257c9b922c4342550ccccbb8_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-209-23wp\"], \"image\": [\"chrome-xenial-20101600-2d400e1627f\"], \"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\": [\"5601-97d7e7d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603114745134105",
"status": "COMPLETED",
"status_changed_ts": "1603122354198182",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/24371",
"builder:Linux Viz",
"buildset:commit/git/f1e3e0264763a7deec1f0ef2f7d43be8b9c6160e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f1e3e0264763a7deec1f0ef2f7d43be8b9c6160e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031436182374854464",
"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/8866006120283801488/+/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:4f59e6884235ff10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603122354269238",
"url": "https://ci.chromium.org/b/8866006120283801488",
"utcnow_ts": "1603122354927601"
}
}
[15:45:54.936] Invocation finished in 2h7m40.122395061s with status SUCCEEDED