[09:35:41.254] New invocation is queued and will start shortly
[09:35:42.331] Starting the invocation (attempt 1)
[09:35:42.371] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:35:42.372] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:35:42.372] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9039152185054588064",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"070fe48744c6cf5a583859b1351118fd2edbd851\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9039152185054588064",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/070fe48744c6cf5a583859b1351118fd2edbd851",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/070fe48744c6cf5a583859b1351118fd2edbd851",
"gitiles_ref:refs/heads/master"
]
}
[09:35:43.446] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1595756142457921",
"id": "8873722123125733680",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"070fe48744c6cf5a583859b1351118fd2edbd851\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1595756143258111",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/23178",
"builder:Linux Viz",
"buildset:commit/git/070fe48744c6cf5a583859b1351118fd2edbd851",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/070fe48744c6cf5a583859b1351118fd2edbd851",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9039152185054588064",
"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/8873722123125733680/+/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": "1595756143258239",
"url": "https://ci.chromium.org/b/8873722123125733680",
"utcnow_ts": "1595756143432644"
}
}
[09:35:43.446] Task URL: https://ci.chromium.org/b/8873722123125733680
[09:35:43.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:2:0) after 1m0s
[09:36:44.040] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:2:0)
[09:36:44.040] Timer tick, asking Buildbucket for the build status
[09:36:44.197] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:36:44.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:3:0) after 1m0s
[09:37:44.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:3:0)
[09:37:44.268] Timer tick, asking Buildbucket for the build status
[09:37:44.358] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:37:44.358] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:4:0) after 1m0s
[09:38:44.408] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:4:0)
[09:38:44.408] Timer tick, asking Buildbucket for the build status
[09:38:44.577] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:38:44.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:5:0) after 1m0s
[09:39:44.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:5:0)
[09:39:44.683] Timer tick, asking Buildbucket for the build status
[09:39:44.796] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:39:44.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:6:0) after 1m0s
[09:40:44.866] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:6:0)
[09:40:44.866] Timer tick, asking Buildbucket for the build status
[09:40:45.032] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:40:45.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:7:0) after 1m0s
[09:41:45.006] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:7:0)
[09:41:45.006] Timer tick, asking Buildbucket for the build status
[09:41:45.093] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:41:45.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:8:0) after 1m0s
[09:42:45.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:8:0)
[09:42:45.158] Timer tick, asking Buildbucket for the build status
[09:42:45.327] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:42:45.327] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:9:0) after 1m0s
[09:43:45.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:9:0)
[09:43:45.351] Timer tick, asking Buildbucket for the build status
[09:43:45.432] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:43:45.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:10:0) after 1m0s
[09:44:45.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:10:0)
[09:44:45.464] Timer tick, asking Buildbucket for the build status
[09:44:45.652] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:44:45.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:11:0) after 1m0s
[09:45:45.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:11:0)
[09:45:45.693] Timer tick, asking Buildbucket for the build status
[09:45:45.919] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:45:45.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:12:0) after 1m0s
[09:46:46.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:12:0)
[09:46:46.003] Timer tick, asking Buildbucket for the build status
[09:46:46.301] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:46:46.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:13:0) after 1m0s
[09:47:46.322] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:13:0)
[09:47:46.322] Timer tick, asking Buildbucket for the build status
[09:47:46.420] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:47:46.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:14:0) after 1m0s
[09:48:46.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:14:0)
[09:48:46.568] Timer tick, asking Buildbucket for the build status
[09:48:46.651] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:48:46.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:15:0) after 1m0s
[09:49:47.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:15:0)
[09:49:47.228] Timer tick, asking Buildbucket for the build status
[09:49:47.336] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:49:47.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:16:0) after 1m0s
[09:50:47.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:16:0)
[09:50:47.421] Timer tick, asking Buildbucket for the build status
[09:50:47.625] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:50:47.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:17:0) after 1m0s
[09:51:47.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:17:0)
[09:51:47.726] Timer tick, asking Buildbucket for the build status
[09:51:47.880] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:51:47.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:18:0) after 1m0s
[09:52:47.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:18:0)
[09:52:47.923] Timer tick, asking Buildbucket for the build status
[09:52:48.088] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:52:48.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:19:0) after 1m0s
[09:53:48.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:19:0)
[09:53:48.134] Timer tick, asking Buildbucket for the build status
[09:53:48.273] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:53:48.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:20:0) after 1m0s
[09:54:48.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:20:0)
[09:54:48.350] Timer tick, asking Buildbucket for the build status
[09:54:48.481] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:54:48.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:21:0) after 1m0s
[09:55:48.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:21:0)
[09:55:48.569] Timer tick, asking Buildbucket for the build status
[09:55:48.703] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:55:48.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:22:0) after 1m0s
[09:56:48.865] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:22:0)
[09:56:48.865] Timer tick, asking Buildbucket for the build status
[09:56:49.094] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:56:49.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:23:0) after 1m0s
[09:57:49.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:23:0)
[09:57:49.121] Timer tick, asking Buildbucket for the build status
[09:57:49.210] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:57:49.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:24:0) after 1m0s
[09:58:49.353] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:24:0)
[09:58:49.353] Timer tick, asking Buildbucket for the build status
[09:58:49.567] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:58:49.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:25:0) after 1m0s
[09:59:49.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:25:0)
[09:59:49.716] Timer tick, asking Buildbucket for the build status
[09:59:49.816] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:59:49.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:26:0) after 1m0s
[10:00:49.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:26:0)
[10:00:49.806] Timer tick, asking Buildbucket for the build status
[10:00:50.084] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:00:50.084] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:27:0) after 1m0s
[10:01:50.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:27:0)
[10:01:50.166] Timer tick, asking Buildbucket for the build status
[10:01:50.426] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:01:50.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:28:0) after 1m0s
[10:02:50.452] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:28:0)
[10:02:50.452] Timer tick, asking Buildbucket for the build status
[10:02:50.608] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:02:50.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:29:0) after 1m0s
[10:03:50.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:29:0)
[10:03:50.630] Timer tick, asking Buildbucket for the build status
[10:03:50.739] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:03:50.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:30:0) after 1m0s
[10:04:50.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:30:0)
[10:04:50.766] Timer tick, asking Buildbucket for the build status
[10:04:50.950] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:04:50.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:31:0) after 1m0s
[10:05:50.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:31:0)
[10:05:50.992] Timer tick, asking Buildbucket for the build status
[10:05:51.163] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:05:51.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:32:0) after 1m0s
[10:06:51.217] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:32:0)
[10:06:51.217] Timer tick, asking Buildbucket for the build status
[10:06:51.308] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:06:51.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:33:0) after 1m0s
[10:07:51.331] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:33:0)
[10:07:51.331] Timer tick, asking Buildbucket for the build status
[10:07:51.596] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:07:51.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:34:0) after 1m0s
[10:08:51.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:34:0)
[10:08:51.621] Timer tick, asking Buildbucket for the build status
[10:08:51.731] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:08:51.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:35:0) after 1m0s
[10:09:51.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:35:0)
[10:09:51.753] Timer tick, asking Buildbucket for the build status
[10:09:51.850] Build 8873722123125733680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:09:51.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:36:0) after 1m0s
[10:10:50.424] Received PubSub notification, asking Buildbucket for the build status
[10:10:50.517] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:51.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:36:0)
[10:10:51.889] Timer tick, asking Buildbucket for the build status
[10:10:52.025] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:52.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:38:0) after 1m0s
[10:11:52.060] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:38:0)
[10:11:52.060] Timer tick, asking Buildbucket for the build status
[10:11:52.462] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:52.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:39:0) after 1m0s
[10:12:52.495] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:39:0)
[10:12:52.495] Timer tick, asking Buildbucket for the build status
[10:12:52.572] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:52.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:40:0) after 1m0s
[10:13:52.635] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:40:0)
[10:13:52.635] Timer tick, asking Buildbucket for the build status
[10:13:52.823] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:52.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:41:0) after 1m0s
[10:14:52.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:41:0)
[10:14:52.852] Timer tick, asking Buildbucket for the build status
[10:14:52.960] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:52.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:42:0) after 1m0s
[10:15:52.988] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:42:0)
[10:15:52.988] Timer tick, asking Buildbucket for the build status
[10:15:53.187] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:53.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:43:0) after 1m0s
[10:16:53.214] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:43:0)
[10:16:53.214] Timer tick, asking Buildbucket for the build status
[10:16:53.311] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:53.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:44:0) after 1m0s
[10:17:53.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:44:0)
[10:17:53.347] Timer tick, asking Buildbucket for the build status
[10:17:53.527] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:53.527] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:45:0) after 1m0s
[10:18:53.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:45:0)
[10:18:53.559] Timer tick, asking Buildbucket for the build status
[10:18:53.681] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:53.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:46:0) after 1m0s
[10:19:53.922] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:46:0)
[10:19:53.922] Timer tick, asking Buildbucket for the build status
[10:19:54.109] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:54.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:47:0) after 1m0s
[10:20:54.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:47:0)
[10:20:54.283] Timer tick, asking Buildbucket for the build status
[10:20:54.421] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:54.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:48:0) after 1m0s
[10:21:54.519] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:48:0)
[10:21:54.519] Timer tick, asking Buildbucket for the build status
[10:21:54.586] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:54.586] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:49:0) after 1m0s
[10:22:54.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:49:0)
[10:22:54.644] Timer tick, asking Buildbucket for the build status
[10:22:55.571] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:55.571] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:50:0) after 1m0s
[10:23:55.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:50:0)
[10:23:55.707] Timer tick, asking Buildbucket for the build status
[10:23:55.997] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:55.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:51:0) after 1m0s
[10:24:56.024] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:51:0)
[10:24:56.024] Timer tick, asking Buildbucket for the build status
[10:24:56.105] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:56.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:52:0) after 1m0s
[10:25:56.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:52:0)
[10:25:56.149] Timer tick, asking Buildbucket for the build status
[10:25:56.407] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:56.407] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:53:0) after 1m0s
[10:26:56.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:53:0)
[10:26:56.434] Timer tick, asking Buildbucket for the build status
[10:26:56.493] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:56.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:54:0) after 1m0s
[10:27:56.527] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:54:0)
[10:27:56.527] Timer tick, asking Buildbucket for the build status
[10:27:56.616] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:56.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:55:0) after 1m0s
[10:28:56.783] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:55:0)
[10:28:56.783] Timer tick, asking Buildbucket for the build status
[10:28:56.871] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:56.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:56:0) after 1m0s
[10:29:56.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:56:0)
[10:29:56.994] Timer tick, asking Buildbucket for the build status
[10:29:57.129] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:57.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:57:0) after 1m0s
[10:30:57.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:57:0)
[10:30:57.238] Timer tick, asking Buildbucket for the build status
[10:30:57.595] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:57.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:58:0) after 1m0s
[10:31:57.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:58:0)
[10:31:57.651] Timer tick, asking Buildbucket for the build status
[10:31:57.894] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:57.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:59:0) after 1m0s
[10:32:57.969] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:59:0)
[10:32:57.969] Timer tick, asking Buildbucket for the build status
[10:32:58.051] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:58.051] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:60:0) after 1m0s
[10:33:58.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:60:0)
[10:33:58.121] Timer tick, asking Buildbucket for the build status
[10:33:58.289] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:58.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:61:0) after 1m0s
[10:34:58.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:61:0)
[10:34:58.324] Timer tick, asking Buildbucket for the build status
[10:34:58.408] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:58.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:62:0) after 1m0s
[10:35:58.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:62:0)
[10:35:58.461] Timer tick, asking Buildbucket for the build status
[10:35:58.602] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:58.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:63:0) after 1m0s
[10:36:58.678] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:63:0)
[10:36:58.678] Timer tick, asking Buildbucket for the build status
[10:36:58.761] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:58.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:64:0) after 1m0s
[10:37:58.789] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:64:0)
[10:37:58.789] Timer tick, asking Buildbucket for the build status
[10:37:58.859] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:58.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:65:0) after 1m0s
[10:38:58.883] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:65:0)
[10:38:58.883] Timer tick, asking Buildbucket for the build status
[10:38:59.022] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:59.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:66:0) after 1m0s
[10:39:59.009] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:66:0)
[10:39:59.009] Timer tick, asking Buildbucket for the build status
[10:39:59.093] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:59.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:67:0) after 1m0s
[10:40:59.122] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:67:0)
[10:40:59.122] Timer tick, asking Buildbucket for the build status
[10:40:59.732] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:59.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:68:0) after 1m0s
[10:41:59.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:68:0)
[10:41:59.836] Timer tick, asking Buildbucket for the build status
[10:42:00.075] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:00.075] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:69:0) after 1m0s
[10:43:00.098] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:69:0)
[10:43:00.098] Timer tick, asking Buildbucket for the build status
[10:43:00.186] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:00.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:70:0) after 1m0s
[10:44:00.314] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:70:0)
[10:44:00.314] Timer tick, asking Buildbucket for the build status
[10:44:00.390] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:00.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:71:0) after 1m0s
[10:45:00.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:71:0)
[10:45:00.379] Timer tick, asking Buildbucket for the build status
[10:45:00.484] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:00.484] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:72:0) after 1m0s
[10:46:01.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:72:0)
[10:46:01.717] Timer tick, asking Buildbucket for the build status
[10:46:01.891] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:01.891] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:73:0) after 1m0s
[10:47:01.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:73:0)
[10:47:01.917] Timer tick, asking Buildbucket for the build status
[10:47:02.009] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:02.009] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:74:0) after 1m0s
[10:48:01.999] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:74:0)
[10:48:01.999] Timer tick, asking Buildbucket for the build status
[10:48:02.272] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:02.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:75:0) after 1m0s
[10:49:02.309] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:75:0)
[10:49:02.309] Timer tick, asking Buildbucket for the build status
[10:49:02.444] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:02.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:76:0) after 1m0s
[10:50:02.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:76:0)
[10:50:02.526] Timer tick, asking Buildbucket for the build status
[10:50:02.621] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:02.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:77:0) after 1m0s
[10:51:02.654] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:77:0)
[10:51:02.654] Timer tick, asking Buildbucket for the build status
[10:51:02.764] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:02.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:78:0) after 1m0s
[10:52:02.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:78:0)
[10:52:02.909] Timer tick, asking Buildbucket for the build status
[10:52:03.021] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:03.021] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:79:0) after 1m0s
[10:53:03.089] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:79:0)
[10:53:03.089] Timer tick, asking Buildbucket for the build status
[10:53:03.323] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:03.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:80:0) after 1m0s
[10:54:03.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:80:0)
[10:54:03.352] Timer tick, asking Buildbucket for the build status
[10:54:03.760] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:03.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:81:0) after 1m0s
[10:55:03.791] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:81:0)
[10:55:03.791] Timer tick, asking Buildbucket for the build status
[10:55:03.866] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:03.866] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:82:0) after 1m0s
[10:56:03.941] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:82:0)
[10:56:03.941] Timer tick, asking Buildbucket for the build status
[10:56:04.294] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:04.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:83:0) after 1m0s
[10:57:04.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:83:0)
[10:57:04.329] Timer tick, asking Buildbucket for the build status
[10:57:04.539] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:04.539] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:84:0) after 1m0s
[10:58:04.577] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:84:0)
[10:58:04.578] Timer tick, asking Buildbucket for the build status
[10:58:04.651] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:04.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:85:0) after 1m0s
[10:59:04.697] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:85:0)
[10:59:04.697] Timer tick, asking Buildbucket for the build status
[10:59:04.766] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:04.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:86:0) after 1m0s
[11:00:04.813] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:86:0)
[11:00:04.813] Timer tick, asking Buildbucket for the build status
[11:00:05.119] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:05.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:87:0) after 1m0s
[11:01:05.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:87:0)
[11:01:05.269] Timer tick, asking Buildbucket for the build status
[11:01:05.419] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:05.419] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:88:0) after 1m0s
[11:02:05.562] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:88:0)
[11:02:05.562] Timer tick, asking Buildbucket for the build status
[11:02:05.675] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:05.676] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:89:0) after 1m0s
[11:03:05.789] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:89:0)
[11:03:05.789] Timer tick, asking Buildbucket for the build status
[11:03:05.868] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:05.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:90:0) after 1m0s
[11:04:05.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:90:0)
[11:04:05.946] Timer tick, asking Buildbucket for the build status
[11:04:06.051] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:06.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:91:0) after 1m0s
[11:05:06.109] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:91:0)
[11:05:06.109] Timer tick, asking Buildbucket for the build status
[11:05:06.363] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:06.363] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:92:0) after 1m0s
[11:06:06.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:92:0)
[11:06:06.405] Timer tick, asking Buildbucket for the build status
[11:06:06.534] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:06.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:93:0) after 1m0s
[11:07:06.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:93:0)
[11:07:06.532] Timer tick, asking Buildbucket for the build status
[11:07:06.603] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:06.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:94:0) after 1m0s
[11:08:06.604] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:94:0)
[11:08:06.604] Timer tick, asking Buildbucket for the build status
[11:08:06.731] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:06.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:95:0) after 1m0s
[11:09:06.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:95:0)
[11:09:06.810] Timer tick, asking Buildbucket for the build status
[11:09:07.063] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:07.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:96:0) after 1m0s
[11:10:07.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:96:0)
[11:10:07.127] Timer tick, asking Buildbucket for the build status
[11:10:07.208] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:07.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:97:0) after 1m0s
[11:11:07.248] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:97:0)
[11:11:07.248] Timer tick, asking Buildbucket for the build status
[11:11:07.600] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:07.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:98:0) after 1m0s
[11:12:07.683] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:98:0)
[11:12:07.683] Timer tick, asking Buildbucket for the build status
[11:12:07.812] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:07.812] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:99:0) after 1m0s
[11:13:07.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:99:0)
[11:13:07.843] Timer tick, asking Buildbucket for the build status
[11:13:08.014] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:08.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:100:0) after 1m0s
[11:14:08.075] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:100:0)
[11:14:08.075] Timer tick, asking Buildbucket for the build status
[11:14:08.176] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:08.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:101:0) after 1m0s
[11:15:08.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:101:0)
[11:15:08.189] Timer tick, asking Buildbucket for the build status
[11:15:08.297] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:08.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:102:0) after 1m0s
[11:16:08.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:102:0)
[11:16:08.357] Timer tick, asking Buildbucket for the build status
[11:16:08.887] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:08.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:103:0) after 1m0s
[11:17:08.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:103:0)
[11:17:08.937] Timer tick, asking Buildbucket for the build status
[11:17:09.043] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:09.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:104:0) after 1m0s
[11:18:09.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:104:0)
[11:18:09.068] Timer tick, asking Buildbucket for the build status
[11:18:09.234] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:09.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:105:0) after 1m0s
[11:19:09.263] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:105:0)
[11:19:09.263] Timer tick, asking Buildbucket for the build status
[11:19:09.342] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:09.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:106:0) after 1m0s
[11:20:09.425] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:106:0)
[11:20:09.425] Timer tick, asking Buildbucket for the build status
[11:20:09.545] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:09.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:107:0) after 1m0s
[11:21:09.577] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:107:0)
[11:21:09.578] Timer tick, asking Buildbucket for the build status
[11:21:09.742] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:09.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:108:0) after 1m0s
[11:22:09.752] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:108:0)
[11:22:09.752] Timer tick, asking Buildbucket for the build status
[11:22:09.845] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:09.845] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:109:0) after 1m0s
[11:23:09.901] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:109:0)
[11:23:09.901] Timer tick, asking Buildbucket for the build status
[11:23:09.981] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:09.981] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:110:0) after 1m0s
[11:24:10.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:110:0)
[11:24:10.008] Timer tick, asking Buildbucket for the build status
[11:24:10.122] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:10.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:111:0) after 1m0s
[11:25:10.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:111:0)
[11:25:10.158] Timer tick, asking Buildbucket for the build status
[11:25:10.429] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:10.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:112:0) after 1m0s
[11:26:10.501] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:112:0)
[11:26:10.501] Timer tick, asking Buildbucket for the build status
[11:26:10.617] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:10.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:113:0) after 1m0s
[11:27:10.676] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:113:0)
[11:27:10.676] Timer tick, asking Buildbucket for the build status
[11:27:10.980] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:10.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:114:0) after 1m0s
[11:28:11.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:114:0)
[11:28:11.053] Timer tick, asking Buildbucket for the build status
[11:28:11.145] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:11.145] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:115:0) after 1m0s
[11:29:11.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:115:0)
[11:29:11.143] Timer tick, asking Buildbucket for the build status
[11:29:11.229] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:11.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:116:0) after 1m0s
[11:30:11.263] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:116:0)
[11:30:11.263] Timer tick, asking Buildbucket for the build status
[11:30:11.388] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:11.388] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:117:0) after 1m0s
[11:31:11.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:117:0)
[11:31:11.436] Timer tick, asking Buildbucket for the build status
[11:31:11.827] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:11.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:118:0) after 1m0s
[11:32:11.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:118:0)
[11:32:11.893] Timer tick, asking Buildbucket for the build status
[11:32:12.149] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:12.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:119:0) after 1m0s
[11:33:12.200] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:119:0)
[11:33:12.200] Timer tick, asking Buildbucket for the build status
[11:33:12.498] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:12.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:120:0) after 1m0s
[11:34:12.758] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:120:0)
[11:34:12.758] Timer tick, asking Buildbucket for the build status
[11:34:13.009] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:13.009] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:121:0) after 1m0s
[11:35:13.093] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:121:0)
[11:35:13.093] Timer tick, asking Buildbucket for the build status
[11:35:13.156] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:13.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:122:0) after 1m0s
[11:36:13.254] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:122:0)
[11:36:13.254] Timer tick, asking Buildbucket for the build status
[11:36:13.696] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:13.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:123:0) after 1m0s
[11:37:13.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:123:0)
[11:37:13.726] Timer tick, asking Buildbucket for the build status
[11:37:13.899] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:13.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:124:0) after 1m0s
[11:38:13.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:124:0)
[11:38:13.978] Timer tick, asking Buildbucket for the build status
[11:38:14.106] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:14.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:125:0) after 1m0s
[11:39:14.181] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:125:0)
[11:39:14.181] Timer tick, asking Buildbucket for the build status
[11:39:14.411] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:14.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:126:0) after 1m0s
[11:40:14.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:126:0)
[11:40:14.550] Timer tick, asking Buildbucket for the build status
[11:40:14.738] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:14.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:127:0) after 1m0s
[11:41:14.763] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:127:0)
[11:41:14.763] Timer tick, asking Buildbucket for the build status
[11:41:15.086] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:15.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:128:0) after 1m0s
[11:42:15.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:128:0)
[11:42:15.134] Timer tick, asking Buildbucket for the build status
[11:42:15.215] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:15.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:129:0) after 1m0s
[11:43:15.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:129:0)
[11:43:15.294] Timer tick, asking Buildbucket for the build status
[11:43:15.362] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:15.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:130:0) after 1m0s
[11:44:15.390] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:130:0)
[11:44:15.390] Timer tick, asking Buildbucket for the build status
[11:44:15.615] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:15.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:131:0) after 1m0s
[11:45:15.668] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:131:0)
[11:45:15.668] Timer tick, asking Buildbucket for the build status
[11:45:15.843] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:15.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:132:0) after 1m0s
[11:46:15.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:132:0)
[11:46:15.872] Timer tick, asking Buildbucket for the build status
[11:46:16.131] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:16.131] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:133:0) after 1m0s
[11:47:16.155] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:133:0)
[11:47:16.155] Timer tick, asking Buildbucket for the build status
[11:47:16.750] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:16.750] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:134:0) after 1m0s
[11:48:16.880] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:134:0)
[11:48:16.880] Timer tick, asking Buildbucket for the build status
[11:48:17.090] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:17.090] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:135:0) after 1m0s
[11:49:17.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:135:0)
[11:49:17.125] Timer tick, asking Buildbucket for the build status
[11:49:17.222] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:17.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:136:0) after 1m0s
[11:50:17.317] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:136:0)
[11:50:17.317] Timer tick, asking Buildbucket for the build status
[11:50:17.468] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:17.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:137:0) after 1m0s
[11:51:17.566] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:137:0)
[11:51:17.566] Timer tick, asking Buildbucket for the build status
[11:51:17.920] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:17.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:138:0) after 1m0s
[11:52:17.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:138:0)
[11:52:17.917] Timer tick, asking Buildbucket for the build status
[11:52:18.186] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:18.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:139:0) after 1m0s
[11:53:18.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:139:0)
[11:53:18.224] Timer tick, asking Buildbucket for the build status
[11:53:18.487] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:18.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:140:0) after 1m0s
[11:54:18.531] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:140:0)
[11:54:18.531] Timer tick, asking Buildbucket for the build status
[11:54:18.605] Build 8873722123125733680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:18.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9039152185054588064:141:0) after 1m0s
[11:55:06.858] Received PubSub notification, asking Buildbucket for the build status
[11:55:07.039] Build 8873722123125733680: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:55:07.039] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1595764506065219",
"created_by": "project:chromium",
"created_ts": "1595756142457921",
"id": "8873722123125733680",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"070fe48744c6cf5a583859b1351118fd2edbd851\"}}",
"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-81-sb8r\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Viz\", \"buildnumber\": 23178, \"got_angle_revision\": \"bef908ee78782e078861208162286c048e0db71a\", \"got_dawn_revision\": \"d5a4775cfc77da29870286a217ea49e4ab3270a3\", \"got_nacl_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"got_revision\": \"070fe48744c6cf5a583859b1351118fd2edbd851\", \"got_revision_cp\": \"refs/heads/master@{#791637}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"4eaf6d79edfa7f42962629fdbe35aac9fd5aac9c\", \"got_v8_revision\": \"74b3eb7ac17f1391c84d7d7351a6f64bbb8ff41c\", \"got_v8_revision_cp\": \"refs/heads/8.6.237@{#1}\", \"got_webrtc_revision\": \"60cbf70944cf845781c14ee176cec26c61aa502a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31788}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"070fe48744c6cf5a583859b1351118fd2edbd851\", \"swarm_hashes\": {\"blink_web_tests\": \"c6f6373b91cf36de59f8549786d8392954224dfc\", \"browser_tests\": \"17724516d24d420ed40eea5fa558ccf41aec4298\", \"content_browsertests\": \"df8a31357190cdbc2bbfbfbb38c31328ddd04dc8\"}, \"swarm_hashes_refs/heads/master(at){#791637}_without_patch\": {\"blink_web_tests\": \"c6f6373b91cf36de59f8549786d8392954224dfc\", \"browser_tests\": \"17724516d24d420ed40eea5fa558ccf41aec4298\", \"content_browsertests\": \"df8a31357190cdbc2bbfbfbb38c31328ddd04dc8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1267e646917891f5f926cdb94ab3368f0c9399d68d76518d691afb23f68811c9_v2\", \"builder_1501dab01e9c937866122f9591ccbdf807ec51c358866e782d3b17f5b75a366a_v2\", \"builder_2bbcd421f4eb1113f3a23522b280d70ced47ef846cc2e40eada60721dff8d17e_v2\", \"builder_40dd468e82eb8077f1d7d116a1070a8cba357c508f0bea5a7358a9e738868cd7_v2\", \"builder_7c33532a05185fab1c9bcf16ffdf6f5c807e6f4d540b9db74c6e737e66354343_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_v2\", \"builder_fb28a6d2872cbe0cfee95c70d0f382580be9fc98bdb4b9be662ba51824506838_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-81-sb8r\"], \"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\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5425-e4e3059\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1595758249590805",
"status": "COMPLETED",
"status_changed_ts": "1595764506450733",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/23178",
"builder:Linux Viz",
"buildset:commit/git/070fe48744c6cf5a583859b1351118fd2edbd851",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/070fe48744c6cf5a583859b1351118fd2edbd851",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9039152185054588064",
"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/8873722123125733680/+/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:4da34bebfc320c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1595764506459323",
"url": "https://ci.chromium.org/b/8873722123125733680",
"utcnow_ts": "1595764507026412"
}
}
[11:55:07.039] Invocation finished in 2h19m25.804753272s with status SUCCEEDED