[00:15:53.909] New invocation is queued and will start shortly
[00:15:54.988] Starting the invocation (attempt 1)
[00:15:55.040] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:15:55.040] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:15:55.040] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9072527087571583760",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"f9270f1f84e1459980ab97dcc0ca2420eb4dbbe1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9072527087571583760",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/f9270f1f84e1459980ab97dcc0ca2420eb4dbbe1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f9270f1f84e1459980ab97dcc0ca2420eb4dbbe1",
"gitiles_ref:refs/heads/master"
]
}
[00:15:56.639] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1563927355323122",
"id": "8907097025423091568",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f9270f1f84e1459980ab97dcc0ca2420eb4dbbe1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563927356365856",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8766",
"builder:ToTiOS",
"buildset:commit/git/f9270f1f84e1459980ab97dcc0ca2420eb4dbbe1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f9270f1f84e1459980ab97dcc0ca2420eb4dbbe1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072527087571583760",
"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/8907097025423091568/+/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": "1563927356366050",
"url": "https://ci.chromium.org/b/8907097025423091568",
"utcnow_ts": "1563927356622436"
}
}
[00:15:56.639] Task URL: https://ci.chromium.org/b/8907097025423091568
[00:15:56.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:2:0) after 1m0s
[00:16:07.221] Received PubSub notification, asking Buildbucket for the build status
[00:16:07.434] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:56.638] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:2:0)
[00:16:56.638] Timer tick, asking Buildbucket for the build status
[00:16:57.147] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:57.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:4:0) after 1m0s
[00:17:57.176] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:4:0)
[00:17:57.176] Timer tick, asking Buildbucket for the build status
[00:18:00.771] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:00.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:5:0) after 1m0s
[00:19:00.855] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:5:0)
[00:19:00.855] Timer tick, asking Buildbucket for the build status
[00:19:01.520] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:01.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:6:0) after 1m0s
[00:20:01.572] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:6:0)
[00:20:01.572] Timer tick, asking Buildbucket for the build status
[00:20:03.118] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:03.118] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:7:0) after 1m0s
[00:21:03.158] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:7:0)
[00:21:03.158] Timer tick, asking Buildbucket for the build status
[00:21:03.435] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:03.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:8:0) after 1m0s
[00:22:03.502] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:8:0)
[00:22:03.502] Timer tick, asking Buildbucket for the build status
[00:22:08.693] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:08.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:9:0) after 1m0s
[00:23:08.753] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:9:0)
[00:23:08.753] Timer tick, asking Buildbucket for the build status
[00:23:09.654] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:09.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:10:0) after 1m0s
[00:24:09.686] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:10:0)
[00:24:09.686] Timer tick, asking Buildbucket for the build status
[00:24:09.839] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:09.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:11:0) after 1m0s
[00:25:09.861] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:11:0)
[00:25:09.861] Timer tick, asking Buildbucket for the build status
[00:25:13.437] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:13.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:12:0) after 1m0s
[00:26:13.539] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:12:0)
[00:26:13.539] Timer tick, asking Buildbucket for the build status
[00:26:14.511] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:14.511] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:13:0) after 1m0s
[00:27:14.780] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:13:0)
[00:27:14.780] Timer tick, asking Buildbucket for the build status
[00:27:14.993] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:14.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:14:0) after 1m0s
[00:28:15.137] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:14:0)
[00:28:15.137] Timer tick, asking Buildbucket for the build status
[00:28:15.833] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:15.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:15:0) after 1m0s
[00:29:15.845] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:15:0)
[00:29:15.845] Timer tick, asking Buildbucket for the build status
[00:29:16.231] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:16.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:16:0) after 1m0s
[00:30:16.268] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:16:0)
[00:30:16.268] Timer tick, asking Buildbucket for the build status
[00:30:16.849] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:16.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:17:0) after 1m0s
[00:31:16.905] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:17:0)
[00:31:16.905] Timer tick, asking Buildbucket for the build status
[00:31:17.401] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:17.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:18:0) after 1m0s
[00:32:17.461] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:18:0)
[00:32:17.461] Timer tick, asking Buildbucket for the build status
[00:32:18.168] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:18.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:19:0) after 1m0s
[00:33:18.329] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:19:0)
[00:33:18.329] Timer tick, asking Buildbucket for the build status
[00:33:18.601] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:18.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:20:0) after 1m0s
[00:34:18.621] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:20:0)
[00:34:18.621] Timer tick, asking Buildbucket for the build status
[00:34:19.183] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:19.183] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:21:0) after 1m0s
[00:35:19.244] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:21:0)
[00:35:19.244] Timer tick, asking Buildbucket for the build status
[00:35:19.427] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:19.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:22:0) after 1m0s
[00:36:19.636] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:22:0)
[00:36:19.636] Timer tick, asking Buildbucket for the build status
[00:36:20.437] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:20.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:23:0) after 1m0s
[00:37:20.528] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:23:0)
[00:37:20.528] Timer tick, asking Buildbucket for the build status
[00:37:21.329] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:21.329] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:24:0) after 1m0s
[00:38:21.400] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:24:0)
[00:38:21.400] Timer tick, asking Buildbucket for the build status
[00:38:22.007] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:22.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:25:0) after 1m0s
[00:39:22.044] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:25:0)
[00:39:22.044] Timer tick, asking Buildbucket for the build status
[00:39:22.446] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:22.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:26:0) after 1m0s
[00:40:22.545] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:26:0)
[00:40:22.545] Timer tick, asking Buildbucket for the build status
[00:40:22.729] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:22.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:27:0) after 1m0s
[00:41:22.820] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:27:0)
[00:41:22.820] Timer tick, asking Buildbucket for the build status
[00:41:23.032] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:23.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:28:0) after 1m0s
[00:42:23.101] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:28:0)
[00:42:23.101] Timer tick, asking Buildbucket for the build status
[00:42:23.312] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:23.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:29:0) after 1m0s
[00:43:23.450] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:29:0)
[00:43:23.450] Timer tick, asking Buildbucket for the build status
[00:43:23.938] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:23.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:30:0) after 1m0s
[00:44:24.292] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:30:0)
[00:44:24.292] Timer tick, asking Buildbucket for the build status
[00:44:25.097] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:25.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:31:0) after 1m0s
[00:45:25.153] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:31:0)
[00:45:25.153] Timer tick, asking Buildbucket for the build status
[00:45:25.348] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:25.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:32:0) after 1m0s
[00:46:25.424] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:32:0)
[00:46:25.424] Timer tick, asking Buildbucket for the build status
[00:46:26.050] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:26.050] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:33:0) after 1m0s
[00:47:26.077] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:33:0)
[00:47:26.077] Timer tick, asking Buildbucket for the build status
[00:47:26.580] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:26.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:34:0) after 1m0s
[00:48:26.619] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:34:0)
[00:48:26.619] Timer tick, asking Buildbucket for the build status
[00:48:26.805] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:26.805] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:35:0) after 1m0s
[00:49:26.840] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:35:0)
[00:49:26.840] Timer tick, asking Buildbucket for the build status
[00:49:27.255] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:27.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:36:0) after 1m0s
[00:50:27.300] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:36:0)
[00:50:27.300] Timer tick, asking Buildbucket for the build status
[00:50:27.535] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:27.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:37:0) after 1m0s
[00:51:27.633] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:37:0)
[00:51:27.633] Timer tick, asking Buildbucket for the build status
[00:51:27.773] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:27.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:38:0) after 1m0s
[00:52:27.853] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:38:0)
[00:52:27.853] Timer tick, asking Buildbucket for the build status
[00:52:28.147] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:28.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:39:0) after 1m0s
[00:53:28.249] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:39:0)
[00:53:28.249] Timer tick, asking Buildbucket for the build status
[00:53:28.431] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:28.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:40:0) after 1m0s
[00:54:28.455] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:40:0)
[00:54:28.455] Timer tick, asking Buildbucket for the build status
[00:54:29.027] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:29.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:41:0) after 1m0s
[00:55:29.044] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:41:0)
[00:55:29.044] Timer tick, asking Buildbucket for the build status
[00:55:32.639] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:32.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:42:0) after 1m0s
[00:56:32.675] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:42:0)
[00:56:32.675] Timer tick, asking Buildbucket for the build status
[00:56:32.887] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:32.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:43:0) after 1m0s
[00:57:32.898] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:43:0)
[00:57:32.898] Timer tick, asking Buildbucket for the build status
[00:57:33.235] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:33.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:44:0) after 1m0s
[00:58:33.258] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:44:0)
[00:58:33.258] Timer tick, asking Buildbucket for the build status
[00:58:33.531] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:33.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:45:0) after 1m0s
[00:59:33.598] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:45:0)
[00:59:33.598] Timer tick, asking Buildbucket for the build status
[00:59:35.695] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:35.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:46:0) after 1m0s
[01:00:35.738] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:46:0)
[01:00:35.738] Timer tick, asking Buildbucket for the build status
[01:00:35.872] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:35.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:47:0) after 1m0s
[01:01:35.916] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:47:0)
[01:01:35.916] Timer tick, asking Buildbucket for the build status
[01:01:36.571] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:36.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:48:0) after 1m0s
[01:02:36.663] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:48:0)
[01:02:36.663] Timer tick, asking Buildbucket for the build status
[01:02:36.878] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:36.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:49:0) after 1m0s
[01:03:36.942] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:49:0)
[01:03:36.942] Timer tick, asking Buildbucket for the build status
[01:03:37.562] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:37.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:50:0) after 1m0s
[01:04:37.600] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:50:0)
[01:04:37.600] Timer tick, asking Buildbucket for the build status
[01:04:38.236] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:38.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:51:0) after 1m0s
[01:05:38.265] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:51:0)
[01:05:38.265] Timer tick, asking Buildbucket for the build status
[01:05:38.726] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:38.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:52:0) after 1m0s
[01:06:38.744] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:52:0)
[01:06:38.744] Timer tick, asking Buildbucket for the build status
[01:06:39.315] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:39.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:53:0) after 1m0s
[01:07:39.334] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:53:0)
[01:07:39.334] Timer tick, asking Buildbucket for the build status
[01:07:39.580] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:39.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:54:0) after 1m0s
[01:08:39.602] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:54:0)
[01:08:39.602] Timer tick, asking Buildbucket for the build status
[01:08:40.437] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:40.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:55:0) after 1m0s
[01:09:40.561] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:55:0)
[01:09:40.561] Timer tick, asking Buildbucket for the build status
[01:09:40.715] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:40.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:56:0) after 1m0s
[01:10:40.726] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:56:0)
[01:10:40.726] Timer tick, asking Buildbucket for the build status
[01:10:45.128] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:45.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:57:0) after 1m0s
[01:11:45.321] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:57:0)
[01:11:45.321] Timer tick, asking Buildbucket for the build status
[01:11:46.044] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:46.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:58:0) after 1m0s
[01:12:46.086] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:58:0)
[01:12:46.086] Timer tick, asking Buildbucket for the build status
[01:12:46.297] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:46.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:59:0) after 1m0s
[01:13:46.413] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:59:0)
[01:13:46.413] Timer tick, asking Buildbucket for the build status
[01:13:46.757] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:46.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:60:0) after 1m0s
[01:14:46.770] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:60:0)
[01:14:46.770] Timer tick, asking Buildbucket for the build status
[01:14:46.908] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:46.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:61:0) after 1m0s
[01:15:47.018] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:61:0)
[01:15:47.018] Timer tick, asking Buildbucket for the build status
[01:15:47.423] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:47.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:62:0) after 1m0s
[01:16:47.427] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:62:0)
[01:16:47.427] Timer tick, asking Buildbucket for the build status
[01:16:47.625] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:47.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:63:0) after 1m0s
[01:17:47.672] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:63:0)
[01:17:47.672] Timer tick, asking Buildbucket for the build status
[01:17:47.896] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:47.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:64:0) after 1m0s
[01:18:47.997] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:64:0)
[01:18:47.997] Timer tick, asking Buildbucket for the build status
[01:18:48.202] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:48.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:65:0) after 1m0s
[01:19:48.303] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:65:0)
[01:19:48.304] Timer tick, asking Buildbucket for the build status
[01:19:49.000] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:49.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:66:0) after 1m0s
[01:20:49.096] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:66:0)
[01:20:49.096] Timer tick, asking Buildbucket for the build status
[01:20:49.254] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:49.254] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:67:0) after 1m0s
[01:21:49.323] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:67:0)
[01:21:49.323] Timer tick, asking Buildbucket for the build status
[01:21:49.702] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:49.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:68:0) after 1m0s
[01:22:49.742] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:68:0)
[01:22:49.742] Timer tick, asking Buildbucket for the build status
[01:22:50.623] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:50.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:69:0) after 1m0s
[01:23:50.714] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:69:0)
[01:23:50.714] Timer tick, asking Buildbucket for the build status
[01:23:50.901] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:50.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:70:0) after 1m0s
[01:24:50.967] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:70:0)
[01:24:50.967] Timer tick, asking Buildbucket for the build status
[01:24:51.476] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:51.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:71:0) after 1m0s
[01:25:51.533] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:71:0)
[01:25:51.533] Timer tick, asking Buildbucket for the build status
[01:25:52.349] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:52.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:72:0) after 1m0s
[01:26:52.466] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:72:0)
[01:26:52.466] Timer tick, asking Buildbucket for the build status
[01:26:52.833] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:52.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:73:0) after 1m0s
[01:27:52.861] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:73:0)
[01:27:52.861] Timer tick, asking Buildbucket for the build status
[01:27:53.238] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:53.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:74:0) after 1m0s
[01:28:53.268] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:74:0)
[01:28:53.268] Timer tick, asking Buildbucket for the build status
[01:28:53.482] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:53.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:75:0) after 1m0s
[01:29:53.570] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:75:0)
[01:29:53.570] Timer tick, asking Buildbucket for the build status
[01:29:54.146] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:54.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:76:0) after 1m0s
[01:30:54.238] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:76:0)
[01:30:54.238] Timer tick, asking Buildbucket for the build status
[01:30:54.434] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:54.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:77:0) after 1m0s
[01:31:54.514] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:77:0)
[01:31:54.514] Timer tick, asking Buildbucket for the build status
[01:31:54.690] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:54.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:78:0) after 1m0s
[01:32:54.772] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:78:0)
[01:32:54.772] Timer tick, asking Buildbucket for the build status
[01:32:54.974] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:54.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:79:0) after 1m0s
[01:33:55.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:79:0)
[01:33:55.037] Timer tick, asking Buildbucket for the build status
[01:33:55.786] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:55.786] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:80:0) after 1m0s
[01:34:55.859] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:80:0)
[01:34:55.859] Timer tick, asking Buildbucket for the build status
[01:34:56.095] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:56.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:81:0) after 1m0s
[01:35:56.168] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:81:0)
[01:35:56.168] Timer tick, asking Buildbucket for the build status
[01:35:56.423] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:56.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:82:0) after 1m0s
[01:36:56.461] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:82:0)
[01:36:56.461] Timer tick, asking Buildbucket for the build status
[01:36:56.950] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:56.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:83:0) after 1m0s
[01:37:57.018] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:83:0)
[01:37:57.018] Timer tick, asking Buildbucket for the build status
[01:37:57.210] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:57.210] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:84:0) after 1m0s
[01:38:57.251] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:84:0)
[01:38:57.251] Timer tick, asking Buildbucket for the build status
[01:38:58.054] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:58.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:85:0) after 1m0s
[01:39:58.131] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:85:0)
[01:39:58.131] Timer tick, asking Buildbucket for the build status
[01:39:58.697] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:58.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:86:0) after 1m0s
[01:40:58.737] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:86:0)
[01:40:58.737] Timer tick, asking Buildbucket for the build status
[01:40:59.019] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:59.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:87:0) after 1m0s
[01:41:59.067] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:87:0)
[01:41:59.067] Timer tick, asking Buildbucket for the build status
[01:41:59.222] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:59.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:88:0) after 1m0s
[01:42:59.257] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:88:0)
[01:42:59.257] Timer tick, asking Buildbucket for the build status
[01:42:59.434] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:59.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:89:0) after 1m0s
[01:43:59.464] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:89:0)
[01:43:59.464] Timer tick, asking Buildbucket for the build status
[01:43:59.922] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:59.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:90:0) after 1m0s
[01:44:59.952] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:90:0)
[01:44:59.952] Timer tick, asking Buildbucket for the build status
[01:45:00.820] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:00.820] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:91:0) after 1m0s
[01:46:00.876] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:91:0)
[01:46:00.876] Timer tick, asking Buildbucket for the build status
[01:46:01.796] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:01.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:92:0) after 1m0s
[01:47:01.867] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:92:0)
[01:47:01.867] Timer tick, asking Buildbucket for the build status
[01:47:02.805] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:02.805] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:93:0) after 1m0s
[01:48:02.842] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:93:0)
[01:48:02.842] Timer tick, asking Buildbucket for the build status
[01:48:03.319] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:03.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:94:0) after 1m0s
[01:49:03.492] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:94:0)
[01:49:03.492] Timer tick, asking Buildbucket for the build status
[01:49:03.669] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:03.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:95:0) after 1m0s
[01:50:03.778] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:95:0)
[01:50:03.778] Timer tick, asking Buildbucket for the build status
[01:50:04.930] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:04.930] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:96:0) after 1m0s
[01:51:05.055] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:96:0)
[01:51:05.055] Timer tick, asking Buildbucket for the build status
[01:51:05.269] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:05.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:97:0) after 1m0s
[01:52:05.321] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:97:0)
[01:52:05.321] Timer tick, asking Buildbucket for the build status
[01:52:05.515] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:05.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:98:0) after 1m0s
[01:53:05.549] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:98:0)
[01:53:05.549] Timer tick, asking Buildbucket for the build status
[01:53:06.219] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:06.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:99:0) after 1m0s
[01:54:06.330] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:99:0)
[01:54:06.330] Timer tick, asking Buildbucket for the build status
[01:54:06.738] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:06.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:100:0) after 1m0s
[01:55:06.748] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:100:0)
[01:55:06.748] Timer tick, asking Buildbucket for the build status
[01:55:06.869] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:06.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:101:0) after 1m0s
[01:56:06.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:101:0)
[01:56:06.975] Timer tick, asking Buildbucket for the build status
[01:56:07.516] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:07.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:102:0) after 1m0s
[01:57:07.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:102:0)
[01:57:07.644] Timer tick, asking Buildbucket for the build status
[01:57:07.801] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:07.801] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:103:0) after 1m0s
[01:58:07.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:103:0)
[01:58:07.971] Timer tick, asking Buildbucket for the build status
[01:58:08.246] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:08.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:104:0) after 1m0s
[01:59:08.360] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:104:0)
[01:59:08.360] Timer tick, asking Buildbucket for the build status
[01:59:09.866] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:09.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:105:0) after 1m0s
[02:00:09.913] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:105:0)
[02:00:09.913] Timer tick, asking Buildbucket for the build status
[02:00:10.080] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:10.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:106:0) after 1m0s
[02:01:10.253] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:106:0)
[02:01:10.253] Timer tick, asking Buildbucket for the build status
[02:01:10.725] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:10.725] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:107:0) after 1m0s
[02:02:10.773] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:107:0)
[02:02:10.773] Timer tick, asking Buildbucket for the build status
[02:02:11.260] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:11.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:108:0) after 1m0s
[02:03:11.277] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:108:0)
[02:03:11.277] Timer tick, asking Buildbucket for the build status
[02:03:12.944] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:12.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:109:0) after 1m0s
[02:04:13.022] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:109:0)
[02:04:13.022] Timer tick, asking Buildbucket for the build status
[02:04:13.481] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:13.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:110:0) after 1m0s
[02:05:13.491] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:110:0)
[02:05:13.491] Timer tick, asking Buildbucket for the build status
[02:05:13.681] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:13.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:111:0) after 1m0s
[02:06:13.862] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:111:0)
[02:06:13.862] Timer tick, asking Buildbucket for the build status
[02:06:14.062] Build 8907097025423091568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:14.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072527087571583760:112:0) after 1m0s
[02:07:10.257] Received PubSub notification, asking Buildbucket for the build status
[02:07:10.414] Build 8907097025423091568: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:07:10.414] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1563934028317914",
"created_by": "project:chromium",
"created_ts": "1563927355323122",
"id": "8907097025423091568",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f9270f1f84e1459980ab97dcc0ca2420eb4dbbe1\"}}",
"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\": 8766, \"got_angle_revision\": \"8bb46c5b9ffc89e3d5eeddcd990fd69bb4cbeecd\", \"got_dawn_revision\": \"8944f0205b04fa5fe396e6f5e4c9298370f96acb\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"f9270f1f84e1459980ab97dcc0ca2420eb4dbbe1\", \"got_revision_cp\": \"refs/heads/master@{#680224}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"4035531228d69a8e3ec475ef75b51db302e70473\", \"got_v8_revision_cp\": \"refs/heads/7.7.299@{#1}\", \"got_webrtc_revision\": \"cfefa0aef329aac0206c5e56efd90b3b0bdb88b6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28646}\", \"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\": \"f9270f1f84e1459980ab97dcc0ca2420eb4dbbe1\", \"swarm_hashes\": {\"0\": \"26aedbfbf66f62c23e74f9f077d64cfa27da2d43\", \"1\": \"a95a8bac262814a1d200aa98e8c154e829a35dde\", \"10\": \"deb722cd0a75f467aaea4e3c6c74b8e58273b0c8\", \"11\": \"5359e1239ff53bb9360227387d7f743b82496bbc\", \"12\": \"deabf0897f07b6502fa3dfec531f6e0b63d2658d\", \"13\": \"d601dc54851991dbb8b9a3cb672f204366a68534\", \"14\": \"dd748d6a62fe61b1a2cc724c854c19cb59f6ce65\", \"15\": \"602cbeb134e95a2ffeff521c342a535b7f87199c\", \"16\": \"906eb33e2b24cf021fddd9fb0321ff19f002ef6c\", \"2\": \"1d1f150e6ffd504f4931b3919fd95b3eefc30244\", \"3\": \"f0595207b951524b8eb137b2605a19615241522e\", \"4\": \"d9c64b3889ea5c48c24fdf168ebc0430b713a797\", \"5\": \"121766cb2656eb3ceb3540eb3c9d36bc4f7ab75c\", \"6\": \"3a54f8040a71013bebf04c4721435de8e6fa3a95\", \"7\": \"3b9400b2de1484c0122f1f23b5079a5346dd3ea3\", \"8\": \"47e8840e2b7afc83d6abfcc6ad4b1d5c9ca88860\", \"9\": \"3daa0105523de2fa4afca7a006bdd15682831821\"}}, \"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": "1563927365899582",
"status": "COMPLETED",
"status_changed_ts": "1563934029513092",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8766",
"builder:ToTiOS",
"buildset:commit/git/f9270f1f84e1459980ab97dcc0ca2420eb4dbbe1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f9270f1f84e1459980ab97dcc0ca2420eb4dbbe1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072527087571583760",
"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/8907097025423091568/+/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:463a27361c999d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1563934029533309",
"url": "https://ci.chromium.org/b/8907097025423091568",
"utcnow_ts": "1563934030403388"
}
}
[02:07:10.414] Invocation finished in 1h51m16.524711166s with status SUCCEEDED