[23:39:29.124] New invocation is queued and will start shortly
[23:39:31.447] Starting the invocation (attempt 1)
[23:39:31.495] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:39:31.495] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:39:31.495] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9049608345984366448",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d18ce3c692f0e988ad947279b1eb5066f125259f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9049608345984366448",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/d18ce3c692f0e988ad947279b1eb5066f125259f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d18ce3c692f0e988ad947279b1eb5066f125259f",
"gitiles_ref:refs/heads/master"
]
}
[23:39:32.535] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1585784371617447",
"id": "8884178282706044544",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d18ce3c692f0e988ad947279b1eb5066f125259f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585784372270791",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/12809",
"builder:ToTiOS",
"buildset:commit/git/d18ce3c692f0e988ad947279b1eb5066f125259f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d18ce3c692f0e988ad947279b1eb5066f125259f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9049608345984366448",
"scheduler_job_id:chromium/ToTiOS",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8884178282706044544/+/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": "1585784372270959",
"url": "https://ci.chromium.org/b/8884178282706044544",
"utcnow_ts": "1585784372524537"
}
}
[23:39:32.535] Task URL: https://ci.chromium.org/b/8884178282706044544
[23:39:32.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:2:0) after 1m0s
[23:40:32.661] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:2:0)
[23:40:32.661] Timer tick, asking Buildbucket for the build status
[23:40:32.828] Build 8884178282706044544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:32.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:3:0) after 1m0s
[23:41:32.850] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:3:0)
[23:41:32.850] Timer tick, asking Buildbucket for the build status
[23:41:33.011] Build 8884178282706044544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:33.011] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:4:0) after 1m0s
[23:42:33.073] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:4:0)
[23:42:33.073] Timer tick, asking Buildbucket for the build status
[23:42:33.328] Build 8884178282706044544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:33.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:5:0) after 1m0s
[23:43:23.039] Received PubSub notification, asking Buildbucket for the build status
[23:43:23.225] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:33.368] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:5:0)
[23:43:33.368] Timer tick, asking Buildbucket for the build status
[23:43:33.602] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:33.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:7:0) after 1m0s
[23:44:33.920] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:7:0)
[23:44:33.920] Timer tick, asking Buildbucket for the build status
[23:44:34.257] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:34.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:8:0) after 1m0s
[23:45:34.634] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:8:0)
[23:45:34.635] Timer tick, asking Buildbucket for the build status
[23:45:34.832] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:34.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:9:0) after 1m0s
[23:46:34.982] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:9:0)
[23:46:34.982] Timer tick, asking Buildbucket for the build status
[23:46:35.100] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:35.100] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:10:0) after 1m0s
[23:47:35.232] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:10:0)
[23:47:35.232] Timer tick, asking Buildbucket for the build status
[23:47:35.357] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:35.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:11:0) after 1m0s
[23:48:35.451] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:11:0)
[23:48:35.451] Timer tick, asking Buildbucket for the build status
[23:48:35.587] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:35.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:12:0) after 1m0s
[23:49:35.637] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:12:0)
[23:49:35.637] Timer tick, asking Buildbucket for the build status
[23:49:35.812] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:35.812] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:13:0) after 1m0s
[23:50:35.983] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:13:0)
[23:50:35.983] Timer tick, asking Buildbucket for the build status
[23:50:36.154] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:36.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:14:0) after 1m0s
[23:51:36.212] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:14:0)
[23:51:36.212] Timer tick, asking Buildbucket for the build status
[23:51:36.388] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:36.388] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:15:0) after 1m0s
[23:52:36.469] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:15:0)
[23:52:36.469] Timer tick, asking Buildbucket for the build status
[23:52:37.052] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:37.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:16:0) after 1m0s
[23:53:37.138] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:16:0)
[23:53:37.138] Timer tick, asking Buildbucket for the build status
[23:53:37.412] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:37.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:17:0) after 1m0s
[23:54:37.508] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:17:0)
[23:54:37.508] Timer tick, asking Buildbucket for the build status
[23:54:37.763] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:37.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:18:0) after 1m0s
[23:55:37.808] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:18:0)
[23:55:37.808] Timer tick, asking Buildbucket for the build status
[23:55:37.966] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:37.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:19:0) after 1m0s
[23:56:37.993] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:19:0)
[23:56:37.993] Timer tick, asking Buildbucket for the build status
[23:56:38.209] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:38.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:20:0) after 1m0s
[23:57:38.244] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:20:0)
[23:57:38.244] Timer tick, asking Buildbucket for the build status
[23:57:38.450] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:38.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:21:0) after 1m0s
[23:58:38.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:21:0)
[23:58:38.650] Timer tick, asking Buildbucket for the build status
[23:58:40.013] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:40.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:22:0) after 1m0s
[23:59:40.174] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:22:0)
[23:59:40.174] Timer tick, asking Buildbucket for the build status
[23:59:40.320] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:40.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:23:0) after 1m0s
[00:00:40.378] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:23:0)
[00:00:40.378] Timer tick, asking Buildbucket for the build status
[00:00:40.633] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:40.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:24:0) after 1m0s
[00:01:40.711] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:24:0)
[00:01:40.711] Timer tick, asking Buildbucket for the build status
[00:01:40.983] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:40.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:25:0) after 1m0s
[00:02:41.085] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:25:0)
[00:02:41.085] Timer tick, asking Buildbucket for the build status
[00:02:41.223] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:41.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:26:0) after 1m0s
[00:03:41.335] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:26:0)
[00:03:41.335] Timer tick, asking Buildbucket for the build status
[00:03:42.314] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:42.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:27:0) after 1m0s
[00:04:42.422] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:27:0)
[00:04:42.422] Timer tick, asking Buildbucket for the build status
[00:04:43.208] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:43.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:28:0) after 1m0s
[00:05:43.271] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:28:0)
[00:05:43.271] Timer tick, asking Buildbucket for the build status
[00:05:43.767] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:43.767] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:29:0) after 1m0s
[00:06:43.815] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:29:0)
[00:06:43.815] Timer tick, asking Buildbucket for the build status
[00:06:44.028] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:44.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:30:0) after 1m0s
[00:07:44.051] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:30:0)
[00:07:44.051] Timer tick, asking Buildbucket for the build status
[00:07:44.287] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:44.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:31:0) after 1m0s
[00:08:44.395] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:31:0)
[00:08:44.395] Timer tick, asking Buildbucket for the build status
[00:08:44.849] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:44.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:32:0) after 1m0s
[00:09:44.963] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:32:0)
[00:09:44.963] Timer tick, asking Buildbucket for the build status
[00:09:45.113] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:45.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:33:0) after 1m0s
[00:10:45.276] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:33:0)
[00:10:45.276] Timer tick, asking Buildbucket for the build status
[00:10:45.591] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:45.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:34:0) after 1m0s
[00:11:45.701] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:34:0)
[00:11:45.701] Timer tick, asking Buildbucket for the build status
[00:11:45.878] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:45.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:35:0) after 1m0s
[00:12:45.976] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:35:0)
[00:12:45.976] Timer tick, asking Buildbucket for the build status
[00:12:46.172] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:46.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:36:0) after 1m0s
[00:13:46.280] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:36:0)
[00:13:46.280] Timer tick, asking Buildbucket for the build status
[00:13:46.708] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:46.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:37:0) after 1m0s
[00:14:46.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:37:0)
[00:14:46.731] Timer tick, asking Buildbucket for the build status
[00:14:47.246] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:47.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:38:0) after 1m0s
[00:15:47.306] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:38:0)
[00:15:47.306] Timer tick, asking Buildbucket for the build status
[00:15:47.506] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:47.506] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:39:0) after 1m0s
[00:16:47.639] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:39:0)
[00:16:47.639] Timer tick, asking Buildbucket for the build status
[00:16:48.994] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:48.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:40:0) after 1m0s
[00:17:49.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:40:0)
[00:17:49.079] Timer tick, asking Buildbucket for the build status
[00:17:49.395] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:49.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:41:0) after 1m0s
[00:18:49.556] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:41:0)
[00:18:49.556] Timer tick, asking Buildbucket for the build status
[00:18:49.806] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:49.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:42:0) after 1m0s
[00:19:50.267] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:42:0)
[00:19:50.267] Timer tick, asking Buildbucket for the build status
[00:19:50.443] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:50.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:43:0) after 1m0s
[00:20:50.666] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:43:0)
[00:20:50.666] Timer tick, asking Buildbucket for the build status
[00:20:50.893] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:50.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:44:0) after 1m0s
[00:21:50.982] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:44:0)
[00:21:50.982] Timer tick, asking Buildbucket for the build status
[00:21:51.126] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:51.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:45:0) after 1m0s
[00:22:51.304] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:45:0)
[00:22:51.304] Timer tick, asking Buildbucket for the build status
[00:22:51.444] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:51.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:46:0) after 1m0s
[00:23:51.610] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:46:0)
[00:23:51.610] Timer tick, asking Buildbucket for the build status
[00:23:53.449] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:53.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:47:0) after 1m0s
[00:24:53.571] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:47:0)
[00:24:53.571] Timer tick, asking Buildbucket for the build status
[00:24:53.949] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:53.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:48:0) after 1m0s
[00:25:53.998] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:48:0)
[00:25:53.998] Timer tick, asking Buildbucket for the build status
[00:25:55.046] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:55.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:49:0) after 1m0s
[00:26:55.107] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:49:0)
[00:26:55.107] Timer tick, asking Buildbucket for the build status
[00:26:55.260] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:55.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:50:0) after 1m0s
[00:27:55.342] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:50:0)
[00:27:55.342] Timer tick, asking Buildbucket for the build status
[00:27:55.521] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:55.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:51:0) after 1m0s
[00:28:55.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:51:0)
[00:28:55.644] Timer tick, asking Buildbucket for the build status
[00:28:55.888] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:55.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:52:0) after 1m0s
[00:29:55.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:52:0)
[00:29:55.975] Timer tick, asking Buildbucket for the build status
[00:29:56.154] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:56.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:53:0) after 1m0s
[00:30:56.278] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:53:0)
[00:30:56.278] Timer tick, asking Buildbucket for the build status
[00:30:56.406] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:56.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:54:0) after 1m0s
[00:31:56.504] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:54:0)
[00:31:56.504] Timer tick, asking Buildbucket for the build status
[00:31:56.697] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:56.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:55:0) after 1m0s
[00:32:56.795] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:55:0)
[00:32:56.795] Timer tick, asking Buildbucket for the build status
[00:32:58.876] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:58.876] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:56:0) after 1m0s
[00:33:58.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:56:0)
[00:33:58.971] Timer tick, asking Buildbucket for the build status
[00:33:59.254] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:59.254] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:57:0) after 1m0s
[00:34:59.320] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:57:0)
[00:34:59.320] Timer tick, asking Buildbucket for the build status
[00:34:59.587] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:59.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:58:0) after 1m0s
[00:35:59.645] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:58:0)
[00:35:59.645] Timer tick, asking Buildbucket for the build status
[00:36:00.269] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:00.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:59:0) after 1m0s
[00:37:00.382] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:59:0)
[00:37:00.382] Timer tick, asking Buildbucket for the build status
[00:37:00.782] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:00.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:60:0) after 1m0s
[00:38:00.849] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:60:0)
[00:38:00.849] Timer tick, asking Buildbucket for the build status
[00:38:01.298] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:01.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:61:0) after 1m0s
[00:39:01.447] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:61:0)
[00:39:01.447] Timer tick, asking Buildbucket for the build status
[00:39:01.714] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:01.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:62:0) after 1m0s
[00:40:01.823] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:62:0)
[00:40:01.823] Timer tick, asking Buildbucket for the build status
[00:40:02.756] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:02.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:63:0) after 1m0s
[00:41:02.931] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:63:0)
[00:41:02.931] Timer tick, asking Buildbucket for the build status
[00:41:03.307] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:03.307] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:64:0) after 1m0s
[00:42:03.404] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:64:0)
[00:42:03.404] Timer tick, asking Buildbucket for the build status
[00:42:05.733] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:05.733] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:65:0) after 1m0s
[00:43:05.780] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:65:0)
[00:43:05.780] Timer tick, asking Buildbucket for the build status
[00:43:05.959] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:05.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:66:0) after 1m0s
[00:44:06.057] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:66:0)
[00:44:06.057] Timer tick, asking Buildbucket for the build status
[00:44:06.304] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:06.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:67:0) after 1m0s
[00:45:06.449] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:67:0)
[00:45:06.449] Timer tick, asking Buildbucket for the build status
[00:45:07.644] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:07.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:68:0) after 1m0s
[00:46:07.810] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:68:0)
[00:46:07.810] Timer tick, asking Buildbucket for the build status
[00:46:08.087] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:08.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:69:0) after 1m0s
[00:47:08.131] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:69:0)
[00:47:08.131] Timer tick, asking Buildbucket for the build status
[00:47:08.362] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:08.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:70:0) after 1m0s
[00:48:08.486] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:70:0)
[00:48:08.486] Timer tick, asking Buildbucket for the build status
[00:48:08.938] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:08.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:71:0) after 1m0s
[00:49:09.015] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:71:0)
[00:49:09.015] Timer tick, asking Buildbucket for the build status
[00:49:09.432] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:09.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:72:0) after 1m0s
[00:50:09.502] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:72:0)
[00:50:09.502] Timer tick, asking Buildbucket for the build status
[00:50:10.648] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:10.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:73:0) after 1m0s
[00:51:10.745] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:73:0)
[00:51:10.745] Timer tick, asking Buildbucket for the build status
[00:51:10.995] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:10.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:74:0) after 1m0s
[00:52:11.025] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:74:0)
[00:52:11.025] Timer tick, asking Buildbucket for the build status
[00:52:11.717] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:11.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:75:0) after 1m0s
[00:53:11.848] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:75:0)
[00:53:11.848] Timer tick, asking Buildbucket for the build status
[00:53:12.308] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:12.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:76:0) after 1m0s
[00:54:12.409] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:76:0)
[00:54:12.409] Timer tick, asking Buildbucket for the build status
[00:54:13.152] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:13.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:77:0) after 1m0s
[00:55:13.195] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:77:0)
[00:55:13.195] Timer tick, asking Buildbucket for the build status
[00:55:13.382] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:13.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:78:0) after 1m0s
[00:56:13.415] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:78:0)
[00:56:13.415] Timer tick, asking Buildbucket for the build status
[00:56:13.714] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:13.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:79:0) after 1m0s
[00:57:13.765] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:79:0)
[00:57:13.765] Timer tick, asking Buildbucket for the build status
[00:57:14.705] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:14.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:80:0) after 1m0s
[00:58:14.798] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:80:0)
[00:58:14.798] Timer tick, asking Buildbucket for the build status
[00:58:15.379] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:15.379] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:81:0) after 1m0s
[00:59:15.429] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:81:0)
[00:59:15.429] Timer tick, asking Buildbucket for the build status
[00:59:15.577] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:15.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:82:0) after 1m0s
[01:00:15.590] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:82:0)
[01:00:15.590] Timer tick, asking Buildbucket for the build status
[01:00:15.762] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:15.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:83:0) after 1m0s
[01:01:15.834] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:83:0)
[01:01:15.834] Timer tick, asking Buildbucket for the build status
[01:01:17.152] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:17.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:84:0) after 1m0s
[01:02:17.231] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:84:0)
[01:02:17.231] Timer tick, asking Buildbucket for the build status
[01:02:17.732] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:17.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:85:0) after 1m0s
[01:03:17.801] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:85:0)
[01:03:17.801] Timer tick, asking Buildbucket for the build status
[01:03:18.852] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:18.852] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:86:0) after 1m0s
[01:04:18.906] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:86:0)
[01:04:18.906] Timer tick, asking Buildbucket for the build status
[01:04:19.032] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:19.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:87:0) after 1m0s
[01:05:19.073] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:87:0)
[01:05:19.073] Timer tick, asking Buildbucket for the build status
[01:05:19.245] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:19.245] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:88:0) after 1m0s
[01:06:19.295] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:88:0)
[01:06:19.295] Timer tick, asking Buildbucket for the build status
[01:06:19.701] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:19.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:89:0) after 1m0s
[01:07:19.704] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:89:0)
[01:07:19.704] Timer tick, asking Buildbucket for the build status
[01:07:19.868] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:19.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:90:0) after 1m0s
[01:08:19.983] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:90:0)
[01:08:19.983] Timer tick, asking Buildbucket for the build status
[01:08:20.593] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:20.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:91:0) after 1m0s
[01:09:20.615] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:91:0)
[01:09:20.615] Timer tick, asking Buildbucket for the build status
[01:09:20.793] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:20.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:92:0) after 1m0s
[01:10:20.890] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:92:0)
[01:10:20.890] Timer tick, asking Buildbucket for the build status
[01:10:21.175] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:21.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:93:0) after 1m0s
[01:11:21.236] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:93:0)
[01:11:21.236] Timer tick, asking Buildbucket for the build status
[01:11:21.683] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:21.683] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:94:0) after 1m0s
[01:12:21.809] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:94:0)
[01:12:21.809] Timer tick, asking Buildbucket for the build status
[01:12:22.331] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:22.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:95:0) after 1m0s
[01:13:22.371] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:95:0)
[01:13:22.371] Timer tick, asking Buildbucket for the build status
[01:13:23.173] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:23.173] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:96:0) after 1m0s
[01:14:23.249] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:96:0)
[01:14:23.249] Timer tick, asking Buildbucket for the build status
[01:14:23.525] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:23.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:97:0) after 1m0s
[01:15:23.561] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:97:0)
[01:15:23.561] Timer tick, asking Buildbucket for the build status
[01:15:23.739] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:23.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:98:0) after 1m0s
[01:16:23.771] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:98:0)
[01:16:23.771] Timer tick, asking Buildbucket for the build status
[01:16:24.287] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:24.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:99:0) after 1m0s
[01:17:24.318] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:99:0)
[01:17:24.318] Timer tick, asking Buildbucket for the build status
[01:17:24.477] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:24.477] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:100:0) after 1m0s
[01:18:24.530] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:100:0)
[01:18:24.530] Timer tick, asking Buildbucket for the build status
[01:18:25.032] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:25.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:101:0) after 1m0s
[01:19:25.066] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:101:0)
[01:19:25.066] Timer tick, asking Buildbucket for the build status
[01:19:25.256] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:25.256] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:102:0) after 1m0s
[01:20:25.327] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:102:0)
[01:20:25.327] Timer tick, asking Buildbucket for the build status
[01:20:25.443] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:25.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:103:0) after 1m0s
[01:21:25.482] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:103:0)
[01:21:25.482] Timer tick, asking Buildbucket for the build status
[01:21:25.687] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:25.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:104:0) after 1m0s
[01:22:25.727] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:104:0)
[01:22:25.727] Timer tick, asking Buildbucket for the build status
[01:22:26.423] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:26.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:105:0) after 1m0s
[01:23:26.466] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:105:0)
[01:23:26.466] Timer tick, asking Buildbucket for the build status
[01:23:27.164] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:27.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:106:0) after 1m0s
[01:24:27.198] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:106:0)
[01:24:27.198] Timer tick, asking Buildbucket for the build status
[01:24:27.648] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:27.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:107:0) after 1m0s
[01:25:27.690] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:107:0)
[01:25:27.690] Timer tick, asking Buildbucket for the build status
[01:25:28.124] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:28.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:108:0) after 1m0s
[01:26:28.177] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:108:0)
[01:26:28.177] Timer tick, asking Buildbucket for the build status
[01:26:28.365] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:28.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:109:0) after 1m0s
[01:27:28.410] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:109:0)
[01:27:28.410] Timer tick, asking Buildbucket for the build status
[01:27:28.538] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:28.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:110:0) after 1m0s
[01:28:28.659] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:110:0)
[01:28:28.659] Timer tick, asking Buildbucket for the build status
[01:28:29.720] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:29.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:111:0) after 1m0s
[01:29:29.848] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:111:0)
[01:29:29.848] Timer tick, asking Buildbucket for the build status
[01:29:30.570] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:30.570] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:112:0) after 1m0s
[01:30:30.647] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:112:0)
[01:30:30.647] Timer tick, asking Buildbucket for the build status
[01:30:30.839] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:30.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:113:0) after 1m0s
[01:31:30.896] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:113:0)
[01:31:30.896] Timer tick, asking Buildbucket for the build status
[01:31:31.090] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:31.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:114:0) after 1m0s
[01:32:31.203] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:114:0)
[01:32:31.203] Timer tick, asking Buildbucket for the build status
[01:32:31.562] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:31.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:115:0) after 1m0s
[01:33:31.634] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:115:0)
[01:33:31.634] Timer tick, asking Buildbucket for the build status
[01:33:31.830] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:31.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:116:0) after 1m0s
[01:34:31.928] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:116:0)
[01:34:31.928] Timer tick, asking Buildbucket for the build status
[01:34:32.285] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:32.285] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:117:0) after 1m0s
[01:35:32.343] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:117:0)
[01:35:32.343] Timer tick, asking Buildbucket for the build status
[01:35:32.698] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:32.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:118:0) after 1m0s
[01:36:32.749] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:118:0)
[01:36:32.749] Timer tick, asking Buildbucket for the build status
[01:36:32.942] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:32.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:119:0) after 1m0s
[01:37:32.977] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:119:0)
[01:37:32.977] Timer tick, asking Buildbucket for the build status
[01:37:33.173] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:33.173] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:120:0) after 1m0s
[01:38:33.208] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:120:0)
[01:38:33.208] Timer tick, asking Buildbucket for the build status
[01:38:34.022] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:34.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:121:0) after 1m0s
[01:39:34.087] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:121:0)
[01:39:34.087] Timer tick, asking Buildbucket for the build status
[01:39:34.355] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:34.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:122:0) after 1m0s
[01:40:34.458] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:122:0)
[01:40:34.458] Timer tick, asking Buildbucket for the build status
[01:40:34.673] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:34.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:123:0) after 1m0s
[01:41:34.747] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:123:0)
[01:41:34.747] Timer tick, asking Buildbucket for the build status
[01:41:34.927] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:34.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:124:0) after 1m0s
[01:42:34.959] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:124:0)
[01:42:34.959] Timer tick, asking Buildbucket for the build status
[01:42:35.312] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:35.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:125:0) after 1m0s
[01:43:35.341] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:125:0)
[01:43:35.341] Timer tick, asking Buildbucket for the build status
[01:43:36.581] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:36.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:126:0) after 1m0s
[01:44:36.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:126:0)
[01:44:36.644] Timer tick, asking Buildbucket for the build status
[01:44:36.849] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:36.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:127:0) after 1m0s
[01:45:36.880] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:127:0)
[01:45:36.880] Timer tick, asking Buildbucket for the build status
[01:45:37.106] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:37.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:128:0) after 1m0s
[01:46:37.168] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:128:0)
[01:46:37.168] Timer tick, asking Buildbucket for the build status
[01:46:37.308] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:37.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:129:0) after 1m0s
[01:47:37.374] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:129:0)
[01:47:37.374] Timer tick, asking Buildbucket for the build status
[01:47:37.877] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:37.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:130:0) after 1m0s
[01:48:37.904] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:130:0)
[01:48:37.904] Timer tick, asking Buildbucket for the build status
[01:48:38.347] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:38.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:131:0) after 1m0s
[01:49:38.456] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:131:0)
[01:49:38.456] Timer tick, asking Buildbucket for the build status
[01:49:38.710] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:38.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:132:0) after 1m0s
[01:50:38.747] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:132:0)
[01:50:38.747] Timer tick, asking Buildbucket for the build status
[01:50:38.874] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:38.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:133:0) after 1m0s
[01:51:38.950] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:133:0)
[01:51:38.950] Timer tick, asking Buildbucket for the build status
[01:51:39.156] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:39.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:134:0) after 1m0s
[01:52:39.214] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:134:0)
[01:52:39.214] Timer tick, asking Buildbucket for the build status
[01:52:39.463] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:39.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:135:0) after 1m0s
[01:53:39.561] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:135:0)
[01:53:39.561] Timer tick, asking Buildbucket for the build status
[01:53:39.877] Build 8884178282706044544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:39.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9049608345984366448:136:0) after 1m0s
[01:54:13.783] Received PubSub notification, asking Buildbucket for the build status
[01:54:13.895] Build 8884178282706044544: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[01:54:13.895] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1585792453212347",
"created_by": "project:chromium",
"created_ts": "1585784371617447",
"failure_reason": "BUILD_FAILURE",
"id": "8884178282706044544",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d18ce3c692f0e988ad947279b1eb5066f125259f\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**ios_web_unittests_iPhone 6s 13.3** failed because of:\\n\\n- WebStateTest.CallLoadURLWithParamsDuringSessionRestore\"}, \"properties\": {\"$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\": \"build282-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 12809, \"got_angle_revision\": \"d30da07270b6a1d0d68ce45d8728dd838fa9ae98\", \"got_clang_revision\": \"n346557-4e0d9925-1\", \"got_dawn_revision\": \"373a3ff26ec7e6fa0f54595c34e35e3fab5af577\", \"got_nacl_revision\": \"ebf11aaad97fde7f91b1c72e0dddaf1653d41f77\", \"got_revision\": \"d18ce3c692f0e988ad947279b1eb5066f125259f\", \"got_revision_cp\": \"refs/heads/master@{#755614}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"cb58662302c8e73845116fc5f14acaa08c037cb2\", \"got_v8_revision\": \"16df139bf0b555ee0d5264eb9a9c7c0c71cf4eda\", \"got_v8_revision_cp\": \"refs/heads/8.3.125@{#1}\", \"got_webrtc_revision\": \"486232025b0bbb67c2f04e9bb4261206f68eefea\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30961}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d18ce3c692f0e988ad947279b1eb5066f125259f\", \"swarm_hashes\": {\"base_unittests\": \"0fd170d605fd2a11d9d9748b408743b433a47419\", \"boringssl_crypto_tests\": \"ab2a2b3ac5890f2fce91ddb83337fbc432b03269\", \"boringssl_ssl_tests\": \"977acb6a56d964ca3af2a49f3e53dc102f9c7034\", \"components_unittests\": \"56719c68cded940a5715be71a3b5783fff8650b3\", \"crypto_unittests\": \"87e5d45175f835f7b5a701741a57220ef1684e7f\", \"gfx_unittests\": \"70ae2e5683ba4ef64a18b7ce51e56523646b61b7\", \"google_apis_unittests\": \"ea20e047efb07a1b237c17a2742f3ff4568923e9\", \"ios_chrome_unittests\": \"f8ce06c86bc27f20593bf5086d15c66deda9aa25\", \"ios_net_unittests\": \"543cc7e6f0e6fa3d99ca87a16631fdbddce6f6a0\", \"ios_web_inttests\": \"ac9ddcd9c79e05481b2c1806bc37c8a97ee5f0f1\", \"ios_web_unittests\": \"8a34ae4feb0a0cd3c8eb3452f151d32813dce571\", \"ios_web_view_inttests\": \"050c425b5b87776e645deb93f15bdf6e76e68781\", \"net_unittests\": \"2c5e0100a93ce6f0ed1ae254487e336a2fcca36a\", \"skia_unittests\": \"4af9f6dab6823704f54ea6ab2ac33abc3546be4b\", \"sql_unittests\": \"5bac3ce3f69d4ca9e7ec6d1984a10e13ae894e4b\", \"ui_base_unittests\": \"a0e6706a4ea8b8284f9e75dcf599c61ac868410d\", \"url_unittests\": \"74cc2b7ad15769429c0eadddb4a14dd4e700597d\"}, \"swarm_hashes_refs/heads/master(at){#755614}_without_patch\": {\"base_unittests\": \"0fd170d605fd2a11d9d9748b408743b433a47419\", \"boringssl_crypto_tests\": \"ab2a2b3ac5890f2fce91ddb83337fbc432b03269\", \"boringssl_ssl_tests\": \"977acb6a56d964ca3af2a49f3e53dc102f9c7034\", \"components_unittests\": \"56719c68cded940a5715be71a3b5783fff8650b3\", \"crypto_unittests\": \"87e5d45175f835f7b5a701741a57220ef1684e7f\", \"gfx_unittests\": \"70ae2e5683ba4ef64a18b7ce51e56523646b61b7\", \"google_apis_unittests\": \"ea20e047efb07a1b237c17a2742f3ff4568923e9\", \"ios_chrome_unittests\": \"f8ce06c86bc27f20593bf5086d15c66deda9aa25\", \"ios_net_unittests\": \"543cc7e6f0e6fa3d99ca87a16631fdbddce6f6a0\", \"ios_web_inttests\": \"ac9ddcd9c79e05481b2c1806bc37c8a97ee5f0f1\", \"ios_web_unittests\": \"8a34ae4feb0a0cd3c8eb3452f151d32813dce571\", \"ios_web_view_inttests\": \"050c425b5b87776e645deb93f15bdf6e76e68781\", \"net_unittests\": \"2c5e0100a93ce6f0ed1ae254487e336a2fcca36a\", \"skia_unittests\": \"4af9f6dab6823704f54ea6ab2ac33abc3546be4b\", \"sql_unittests\": \"5bac3ce3f69d4ca9e7ec6d1984a10e13ae894e4b\", \"ui_base_unittests\": \"a0e6706a4ea8b8284f9e75dcf599c61ac868410d\", \"url_unittests\": \"74cc2b7ad15769429c0eadddb4a14dd4e700597d\"}, \"xcode_build_version\": \"11c29\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11a1027\", \"xcode_ios_11c29\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build282-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4916-b2318d4\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**ios_web_unittests_iPhone 6s 13.3** failed because of:\\n\\n- WebStateTest.CallLoadURLWithParamsDuringSessionRestore\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585784602193492",
"status": "COMPLETED",
"status_changed_ts": "1585784602763872",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/12809",
"builder:ToTiOS",
"buildset:commit/git/d18ce3c692f0e988ad947279b1eb5066f125259f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d18ce3c692f0e988ad947279b1eb5066f125259f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9049608345984366448",
"scheduler_job_id:chromium/ToTiOS",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8884178282706044544/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4b50eec5ffe71210",
"user_agent:luci-scheduler"
],
"updated_ts": "1585792453448946",
"url": "https://ci.chromium.org/b/8884178282706044544",
"utcnow_ts": "1585792453882211"
}
}
[01:54:13.895] Invocation finished in 2h14m44.788311149s with status FAILED