[02:58:38.935] New invocation is queued and will start shortly
[02:58:40.270] Starting the invocation (attempt 1)
[02:58:40.320] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:58:40.321] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:58:40.321] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9071520281569694432",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"a915707181bbd482f2862c54de71c2f60e1604ad\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9071520281569694432",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/a915707181bbd482f2862c54de71c2f60e1604ad",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a915707181bbd482f2862c54de71c2f60e1604ad",
"gitiles_ref:refs/heads/master"
]
}
[02:58:41.117] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1564887520528420",
"id": "8906090219233485968",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"a915707181bbd482f2862c54de71c2f60e1604ad\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1564887520979925",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8971",
"builder:ToTiOS",
"buildset:commit/git/a915707181bbd482f2862c54de71c2f60e1604ad",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a915707181bbd482f2862c54de71c2f60e1604ad",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071520281569694432",
"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/8906090219233485968/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:ios/unified_builder_tester",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1564887520980018",
"url": "https://ci.chromium.org/b/8906090219233485968",
"utcnow_ts": "1564887521104913"
}
}
[02:58:41.117] Task URL: https://ci.chromium.org/b/8906090219233485968
[02:58:41.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:2:0) after 1m0s
[02:59:15.705] Received PubSub notification, asking Buildbucket for the build status
[02:59:16.007] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:41.211] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:2:0)
[02:59:41.211] Timer tick, asking Buildbucket for the build status
[02:59:41.922] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:41.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:4:0) after 1m0s
[03:00:42.004] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:4:0)
[03:00:42.004] Timer tick, asking Buildbucket for the build status
[03:00:42.225] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:42.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:5:0) after 1m0s
[03:01:42.244] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:5:0)
[03:01:42.244] Timer tick, asking Buildbucket for the build status
[03:01:43.695] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:43.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:6:0) after 1m0s
[03:02:43.821] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:6:0)
[03:02:43.821] Timer tick, asking Buildbucket for the build status
[03:02:44.140] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:44.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:7:0) after 1m0s
[03:03:44.216] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:7:0)
[03:03:44.216] Timer tick, asking Buildbucket for the build status
[03:03:44.863] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:44.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:8:0) after 1m0s
[03:04:44.847] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:8:0)
[03:04:44.847] Timer tick, asking Buildbucket for the build status
[03:04:45.922] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:45.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:9:0) after 1m0s
[03:05:45.947] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:9:0)
[03:05:45.947] Timer tick, asking Buildbucket for the build status
[03:05:46.189] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:46.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:10:0) after 1m0s
[03:06:46.209] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:10:0)
[03:06:46.209] Timer tick, asking Buildbucket for the build status
[03:06:46.728] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:46.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:11:0) after 1m0s
[03:07:46.747] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:11:0)
[03:07:46.747] Timer tick, asking Buildbucket for the build status
[03:07:47.228] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:47.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:12:0) after 1m0s
[03:08:47.262] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:12:0)
[03:08:47.262] Timer tick, asking Buildbucket for the build status
[03:08:47.490] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:47.490] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:13:0) after 1m0s
[03:09:47.557] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:13:0)
[03:09:47.557] Timer tick, asking Buildbucket for the build status
[03:09:47.814] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:47.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:14:0) after 1m0s
[03:10:47.838] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:14:0)
[03:10:47.838] Timer tick, asking Buildbucket for the build status
[03:10:49.393] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:49.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:15:0) after 1m0s
[03:11:49.453] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:15:0)
[03:11:49.453] Timer tick, asking Buildbucket for the build status
[03:11:49.631] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:49.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:16:0) after 1m0s
[03:12:49.656] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:16:0)
[03:12:49.656] Timer tick, asking Buildbucket for the build status
[03:12:50.064] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:50.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:17:0) after 1m0s
[03:13:50.183] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:17:0)
[03:13:50.183] Timer tick, asking Buildbucket for the build status
[03:13:50.434] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:50.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:18:0) after 1m0s
[03:14:50.509] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:18:0)
[03:14:50.509] Timer tick, asking Buildbucket for the build status
[03:14:50.756] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:50.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:19:0) after 1m0s
[03:15:50.861] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:19:0)
[03:15:50.861] Timer tick, asking Buildbucket for the build status
[03:15:51.514] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:51.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:20:0) after 1m0s
[03:16:51.540] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:20:0)
[03:16:51.540] Timer tick, asking Buildbucket for the build status
[03:16:51.771] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:51.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:21:0) after 1m0s
[03:17:51.893] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:21:0)
[03:17:51.893] Timer tick, asking Buildbucket for the build status
[03:17:52.205] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:52.205] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:22:0) after 1m0s
[03:18:52.184] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:22:0)
[03:18:52.184] Timer tick, asking Buildbucket for the build status
[03:18:52.511] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:52.511] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:23:0) after 1m0s
[03:19:52.567] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:23:0)
[03:19:52.567] Timer tick, asking Buildbucket for the build status
[03:19:52.727] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:52.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:24:0) after 1m0s
[03:20:52.718] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:24:0)
[03:20:52.718] Timer tick, asking Buildbucket for the build status
[03:20:53.043] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:53.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:25:0) after 1m0s
[03:21:53.065] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:25:0)
[03:21:53.065] Timer tick, asking Buildbucket for the build status
[03:21:53.299] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:53.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:26:0) after 1m0s
[03:22:53.370] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:26:0)
[03:22:53.370] Timer tick, asking Buildbucket for the build status
[03:22:53.910] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:53.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:27:0) after 1m0s
[03:23:53.930] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:27:0)
[03:23:53.930] Timer tick, asking Buildbucket for the build status
[03:23:54.547] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:54.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:28:0) after 1m0s
[03:24:54.692] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:28:0)
[03:24:54.692] Timer tick, asking Buildbucket for the build status
[03:24:55.120] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:55.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:29:0) after 1m0s
[03:25:55.181] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:29:0)
[03:25:55.181] Timer tick, asking Buildbucket for the build status
[03:25:55.664] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:55.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:30:0) after 1m0s
[03:26:55.686] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:30:0)
[03:26:55.686] Timer tick, asking Buildbucket for the build status
[03:26:56.020] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:56.020] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:31:0) after 1m0s
[03:27:56.044] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:31:0)
[03:27:56.044] Timer tick, asking Buildbucket for the build status
[03:27:58.355] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:58.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:32:0) after 1m0s
[03:28:58.501] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:32:0)
[03:28:58.501] Timer tick, asking Buildbucket for the build status
[03:28:59.319] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:59.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:33:0) after 1m0s
[03:29:59.343] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:33:0)
[03:29:59.343] Timer tick, asking Buildbucket for the build status
[03:29:59.736] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:59.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:34:0) after 1m0s
[03:30:59.758] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:34:0)
[03:30:59.758] Timer tick, asking Buildbucket for the build status
[03:31:00.145] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:00.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:35:0) after 1m0s
[03:32:00.199] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:35:0)
[03:32:00.199] Timer tick, asking Buildbucket for the build status
[03:32:00.862] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:00.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:36:0) after 1m0s
[03:33:00.899] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:36:0)
[03:33:00.899] Timer tick, asking Buildbucket for the build status
[03:33:01.104] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:01.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:37:0) after 1m0s
[03:34:01.156] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:37:0)
[03:34:01.156] Timer tick, asking Buildbucket for the build status
[03:34:01.934] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:01.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:38:0) after 1m0s
[03:35:01.993] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:38:0)
[03:35:01.993] Timer tick, asking Buildbucket for the build status
[03:35:02.553] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:02.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:39:0) after 1m0s
[03:36:02.663] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:39:0)
[03:36:02.663] Timer tick, asking Buildbucket for the build status
[03:36:02.867] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:02.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:40:0) after 1m0s
[03:37:02.922] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:40:0)
[03:37:02.922] Timer tick, asking Buildbucket for the build status
[03:37:03.338] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:03.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:41:0) after 1m0s
[03:38:03.346] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:41:0)
[03:38:03.346] Timer tick, asking Buildbucket for the build status
[03:38:03.602] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:03.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:42:0) after 1m0s
[03:39:03.634] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:42:0)
[03:39:03.634] Timer tick, asking Buildbucket for the build status
[03:39:03.844] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:03.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:43:0) after 1m0s
[03:40:03.867] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:43:0)
[03:40:03.867] Timer tick, asking Buildbucket for the build status
[03:40:04.117] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:04.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:44:0) after 1m0s
[03:41:04.150] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:44:0)
[03:41:04.150] Timer tick, asking Buildbucket for the build status
[03:41:04.465] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:04.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:45:0) after 1m0s
[03:42:04.538] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:45:0)
[03:42:04.538] Timer tick, asking Buildbucket for the build status
[03:42:05.356] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:05.356] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:46:0) after 1m0s
[03:43:05.384] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:46:0)
[03:43:05.384] Timer tick, asking Buildbucket for the build status
[03:43:05.519] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:05.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:47:0) after 1m0s
[03:44:05.550] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:47:0)
[03:44:05.550] Timer tick, asking Buildbucket for the build status
[03:44:05.802] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:05.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:48:0) after 1m0s
[03:45:05.825] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:48:0)
[03:45:05.825] Timer tick, asking Buildbucket for the build status
[03:45:06.025] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:06.025] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:49:0) after 1m0s
[03:46:06.058] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:49:0)
[03:46:06.058] Timer tick, asking Buildbucket for the build status
[03:46:06.704] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:06.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:50:0) after 1m0s
[03:47:06.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:50:0)
[03:47:06.731] Timer tick, asking Buildbucket for the build status
[03:47:06.972] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:06.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:51:0) after 1m0s
[03:48:07.048] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:51:0)
[03:48:07.048] Timer tick, asking Buildbucket for the build status
[03:48:07.718] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:07.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:52:0) after 1m0s
[03:49:07.750] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:52:0)
[03:49:07.750] Timer tick, asking Buildbucket for the build status
[03:49:08.431] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:08.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:53:0) after 1m0s
[03:50:08.457] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:53:0)
[03:50:08.458] Timer tick, asking Buildbucket for the build status
[03:50:08.767] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:08.767] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:54:0) after 1m0s
[03:51:08.800] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:54:0)
[03:51:08.800] Timer tick, asking Buildbucket for the build status
[03:51:08.981] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:08.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:55:0) after 1m0s
[03:52:09.009] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:55:0)
[03:52:09.009] Timer tick, asking Buildbucket for the build status
[03:52:09.353] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:09.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:56:0) after 1m0s
[03:53:09.474] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:56:0)
[03:53:09.474] Timer tick, asking Buildbucket for the build status
[03:53:10.272] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:10.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:57:0) after 1m0s
[03:54:10.296] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:57:0)
[03:54:10.296] Timer tick, asking Buildbucket for the build status
[03:54:11.058] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:11.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:58:0) after 1m0s
[03:55:11.092] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:58:0)
[03:55:11.092] Timer tick, asking Buildbucket for the build status
[03:55:11.411] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:11.411] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:59:0) after 1m0s
[03:56:11.532] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:59:0)
[03:56:11.532] Timer tick, asking Buildbucket for the build status
[03:56:13.114] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:13.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:60:0) after 1m0s
[03:57:13.101] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:60:0)
[03:57:13.101] Timer tick, asking Buildbucket for the build status
[03:57:13.482] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:13.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:61:0) after 1m0s
[03:58:13.534] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:61:0)
[03:58:13.534] Timer tick, asking Buildbucket for the build status
[03:58:13.705] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:13.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:62:0) after 1m0s
[03:59:13.730] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:62:0)
[03:59:13.730] Timer tick, asking Buildbucket for the build status
[03:59:16.086] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:16.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:63:0) after 1m0s
[04:00:16.213] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:63:0)
[04:00:16.213] Timer tick, asking Buildbucket for the build status
[04:00:17.512] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:17.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:64:0) after 1m0s
[04:01:17.535] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:64:0)
[04:01:17.535] Timer tick, asking Buildbucket for the build status
[04:01:18.047] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:18.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:65:0) after 1m0s
[04:02:18.068] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:65:0)
[04:02:18.068] Timer tick, asking Buildbucket for the build status
[04:02:18.317] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:18.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:66:0) after 1m0s
[04:03:18.342] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:66:0)
[04:03:18.342] Timer tick, asking Buildbucket for the build status
[04:03:18.848] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:18.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:67:0) after 1m0s
[04:04:18.868] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:67:0)
[04:04:18.868] Timer tick, asking Buildbucket for the build status
[04:04:19.430] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:19.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:68:0) after 1m0s
[04:05:19.450] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:68:0)
[04:05:19.450] Timer tick, asking Buildbucket for the build status
[04:05:19.716] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:19.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:69:0) after 1m0s
[04:06:19.754] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:69:0)
[04:06:19.754] Timer tick, asking Buildbucket for the build status
[04:06:20.013] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:20.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:70:0) after 1m0s
[04:07:20.145] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:70:0)
[04:07:20.145] Timer tick, asking Buildbucket for the build status
[04:07:20.279] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:20.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:71:0) after 1m0s
[04:08:20.380] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:71:0)
[04:08:20.380] Timer tick, asking Buildbucket for the build status
[04:08:20.562] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:20.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:72:0) after 1m0s
[04:09:20.616] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:72:0)
[04:09:20.616] Timer tick, asking Buildbucket for the build status
[04:09:21.024] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:21.024] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:73:0) after 1m0s
[04:10:21.049] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:73:0)
[04:10:21.049] Timer tick, asking Buildbucket for the build status
[04:10:21.256] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:21.256] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:74:0) after 1m0s
[04:11:21.492] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:74:0)
[04:11:21.492] Timer tick, asking Buildbucket for the build status
[04:11:22.563] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:22.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:75:0) after 1m0s
[04:12:22.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:75:0)
[04:12:22.643] Timer tick, asking Buildbucket for the build status
[04:12:23.843] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:23.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:76:0) after 1m0s
[04:13:23.960] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:76:0)
[04:13:23.960] Timer tick, asking Buildbucket for the build status
[04:13:24.294] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:24.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:77:0) after 1m0s
[04:14:24.362] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:77:0)
[04:14:24.362] Timer tick, asking Buildbucket for the build status
[04:14:24.573] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:24.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:78:0) after 1m0s
[04:15:24.601] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:78:0)
[04:15:24.601] Timer tick, asking Buildbucket for the build status
[04:15:25.056] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:25.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:79:0) after 1m0s
[04:16:25.131] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:79:0)
[04:16:25.131] Timer tick, asking Buildbucket for the build status
[04:16:25.338] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:25.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:80:0) after 1m0s
[04:17:25.386] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:80:0)
[04:17:25.386] Timer tick, asking Buildbucket for the build status
[04:17:25.568] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:25.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:81:0) after 1m0s
[04:18:25.783] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:81:0)
[04:18:25.783] Timer tick, asking Buildbucket for the build status
[04:18:26.223] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:26.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:82:0) after 1m0s
[04:19:26.303] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:82:0)
[04:19:26.303] Timer tick, asking Buildbucket for the build status
[04:19:26.452] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:26.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:83:0) after 1m0s
[04:20:26.754] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:83:0)
[04:20:26.754] Timer tick, asking Buildbucket for the build status
[04:20:26.979] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:26.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:84:0) after 1m0s
[04:21:27.082] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:84:0)
[04:21:27.082] Timer tick, asking Buildbucket for the build status
[04:21:27.243] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:27.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:85:0) after 1m0s
[04:22:27.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:85:0)
[04:22:27.275] Timer tick, asking Buildbucket for the build status
[04:22:27.449] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:27.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:86:0) after 1m0s
[04:23:27.544] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:86:0)
[04:23:27.544] Timer tick, asking Buildbucket for the build status
[04:23:27.746] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:27.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:87:0) after 1m0s
[04:24:28.018] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:87:0)
[04:24:28.018] Timer tick, asking Buildbucket for the build status
[04:24:28.181] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:28.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:88:0) after 1m0s
[04:25:28.229] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:88:0)
[04:25:28.229] Timer tick, asking Buildbucket for the build status
[04:25:28.576] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:28.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:89:0) after 1m0s
[04:26:28.701] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:89:0)
[04:26:28.701] Timer tick, asking Buildbucket for the build status
[04:26:28.999] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:28.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:90:0) after 1m0s
[04:27:29.077] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:90:0)
[04:27:29.077] Timer tick, asking Buildbucket for the build status
[04:27:30.062] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:30.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:91:0) after 1m0s
[04:28:30.168] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:91:0)
[04:28:30.168] Timer tick, asking Buildbucket for the build status
[04:28:30.386] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:30.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:92:0) after 1m0s
[04:29:30.556] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:92:0)
[04:29:30.556] Timer tick, asking Buildbucket for the build status
[04:29:31.277] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:31.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:93:0) after 1m0s
[04:30:31.525] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:93:0)
[04:30:31.525] Timer tick, asking Buildbucket for the build status
[04:30:31.655] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:31.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:94:0) after 1m0s
[04:31:31.764] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:94:0)
[04:31:31.764] Timer tick, asking Buildbucket for the build status
[04:31:32.482] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:32.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:95:0) after 1m0s
[04:32:32.515] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:95:0)
[04:32:32.515] Timer tick, asking Buildbucket for the build status
[04:32:33.395] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:33.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:96:0) after 1m0s
[04:33:33.422] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:96:0)
[04:33:33.422] Timer tick, asking Buildbucket for the build status
[04:33:33.571] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:33.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:97:0) after 1m0s
[04:34:33.605] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:97:0)
[04:34:33.605] Timer tick, asking Buildbucket for the build status
[04:34:34.240] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:34.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:98:0) after 1m0s
[04:35:34.302] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:98:0)
[04:35:34.302] Timer tick, asking Buildbucket for the build status
[04:35:34.569] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:34.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:99:0) after 1m0s
[04:36:34.596] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:99:0)
[04:36:34.596] Timer tick, asking Buildbucket for the build status
[04:36:38.429] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:38.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:100:0) after 1m0s
[04:37:38.483] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:100:0)
[04:37:38.483] Timer tick, asking Buildbucket for the build status
[04:37:39.625] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:39.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:101:0) after 1m0s
[04:38:39.631] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:101:0)
[04:38:39.631] Timer tick, asking Buildbucket for the build status
[04:38:39.936] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:39.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:102:0) after 1m0s
[04:39:39.997] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:102:0)
[04:39:39.997] Timer tick, asking Buildbucket for the build status
[04:39:41.038] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:41.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:103:0) after 1m0s
[04:40:41.072] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:103:0)
[04:40:41.072] Timer tick, asking Buildbucket for the build status
[04:40:41.222] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:41.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:104:0) after 1m0s
[04:41:41.292] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:104:0)
[04:41:41.292] Timer tick, asking Buildbucket for the build status
[04:41:41.737] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:41.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:105:0) after 1m0s
[04:42:41.798] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:105:0)
[04:42:41.798] Timer tick, asking Buildbucket for the build status
[04:42:42.088] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:42.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:106:0) after 1m0s
[04:43:42.195] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:106:0)
[04:43:42.195] Timer tick, asking Buildbucket for the build status
[04:43:42.596] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:42.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:107:0) after 1m0s
[04:44:42.623] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:107:0)
[04:44:42.623] Timer tick, asking Buildbucket for the build status
[04:44:42.793] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:42.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:108:0) after 1m0s
[04:45:42.854] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:108:0)
[04:45:42.854] Timer tick, asking Buildbucket for the build status
[04:45:43.301] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:43.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:109:0) after 1m0s
[04:46:43.377] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:109:0)
[04:46:43.377] Timer tick, asking Buildbucket for the build status
[04:46:43.707] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:43.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:110:0) after 1m0s
[04:47:43.797] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:110:0)
[04:47:43.797] Timer tick, asking Buildbucket for the build status
[04:47:44.330] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:44.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:111:0) after 1m0s
[04:48:44.588] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:111:0)
[04:48:44.588] Timer tick, asking Buildbucket for the build status
[04:48:44.990] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:44.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:112:0) after 1m0s
[04:49:45.047] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:112:0)
[04:49:45.047] Timer tick, asking Buildbucket for the build status
[04:49:45.220] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:45.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:113:0) after 1m0s
[04:50:45.246] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:113:0)
[04:50:45.246] Timer tick, asking Buildbucket for the build status
[04:50:45.511] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:45.511] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:114:0) after 1m0s
[04:51:45.604] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:114:0)
[04:51:45.604] Timer tick, asking Buildbucket for the build status
[04:51:45.949] Build 8906090219233485968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:45.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071520281569694432:115:0) after 1m0s
[04:52:22.231] Received PubSub notification, asking Buildbucket for the build status
[04:52:22.386] Build 8906090219233485968: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:52:22.386] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1564894341234203",
"created_by": "project:chromium",
"created_ts": "1564887520528420",
"id": "8906090219233485968",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"a915707181bbd482f2862c54de71c2f60e1604ad\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": 8971, \"got_angle_revision\": \"dc2c5c5a419e45891ec5898e675b8f447b1bd9fa\", \"got_dawn_revision\": \"bfc9cee5d3bea7e37ff26f2952d2d112f3776790\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"a915707181bbd482f2862c54de71c2f60e1604ad\", \"got_revision_cp\": \"refs/heads/master@{#683870}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"7550297429f9368192c5ef4570696526e8e0b773\", \"got_v8_revision_cp\": \"refs/heads/7.8.58@{#1}\", \"got_webrtc_revision\": \"fedd625e0cc634a6ae12683e7bf61f6bc01e677d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28752}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"ios/unified_builder_tester\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"a915707181bbd482f2862c54de71c2f60e1604ad\", \"swarm_hashes\": {\"0\": \"07d64d59e389683c8739ae11c541a126fb0c38d7\", \"1\": \"2cf659e2a376c9ee4e6d386a6e0086201bd49e7c\", \"10\": \"1645691ea8f1f01106a90b2bd87a8b941b3b3c82\", \"11\": \"c3c4eff11b44d74ef343052874bea02820f54a17\", \"12\": \"ebd0dccc3ee3b73cd759629257b2849185b1b621\", \"13\": \"79b2ed5def80e0ec9f25dd1f3bc3158fd259bd25\", \"14\": \"4d0828453042ae58038f5d6a889b830c72f60368\", \"15\": \"b02b6878dc9622cb81578d826c50000d10c3901e\", \"16\": \"0af7b1d2e2dae2a9591fe91771cd42b1ffc72ec0\", \"2\": \"0dbe87e62f2be718d521e25e9331d22105bb6093\", \"3\": \"0d86909aa0400f3201d38bf5626ae5f9bc500bde\", \"4\": \"dfbbba2c41f163091b45f0f27bfd246f428f8a62\", \"5\": \"6dd9b5f1b09a16c16beff8a184d8200efd4b160b\", \"6\": \"8c778ac25b96d73f4800d23bd69a2f428f05a124\", \"7\": \"5bf7f09ddfe8e8416d133825fa8963eab324f572\", \"8\": \"5da990a4775ec2cdd4d0d9236e045c0cce7a2165\", \"9\": \"c7ba6c922e3486d396cefa7ab7e8ab8363c67f98\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_10b61\"], \"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.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4382-5929880\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1564887555035139",
"status": "COMPLETED",
"status_changed_ts": "1564894341743360",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8971",
"builder:ToTiOS",
"buildset:commit/git/a915707181bbd482f2862c54de71c2f60e1604ad",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a915707181bbd482f2862c54de71c2f60e1604ad",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071520281569694432",
"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/8906090219233485968/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:ios/unified_builder_tester",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:46736221398cf710",
"user_agent:luci-scheduler"
],
"updated_ts": "1564894341748816",
"url": "https://ci.chromium.org/b/8906090219233485968",
"utcnow_ts": "1564894342346316"
}
}
[04:52:22.386] Invocation finished in 1h53m43.470398319s with status SUCCEEDED