[16:33:12.434] New invocation is queued and will start shortly
[16:33:20.582] Starting the invocation (attempt 1)
[16:33:20.621] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:33:20.621] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:33:20.621] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9076633061076855152",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"4bad77148cc4a36373e40cf985444bc649c0eeff\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9076633061076855152",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/4bad77148cc4a36373e40cf985444bc649c0eeff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4bad77148cc4a36373e40cf985444bc649c0eeff",
"gitiles_ref:refs/heads/master"
]
}
[16:33:22.514] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1560011601290040",
"id": "8911202991123724000",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4bad77148cc4a36373e40cf985444bc649c0eeff\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1560011602400311",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12512",
"builder:ToTiOSDevice",
"buildset:commit/git/4bad77148cc4a36373e40cf985444bc649c0eeff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4bad77148cc4a36373e40cf985444bc649c0eeff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076633061076855152",
"scheduler_job_id:chromium/ToTiOSDevice",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8911202991123724000/+/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": "1560011602400409",
"url": "https://ci.chromium.org/b/8911202991123724000",
"utcnow_ts": "1560011602506584"
}
}
[16:33:22.514] Task URL: https://ci.chromium.org/b/8911202991123724000
[16:33:22.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:2:0) after 1m0s
[16:34:25.078] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:2:0)
[16:34:25.078] Timer tick, asking Buildbucket for the build status
[16:34:26.225] Build 8911202991123724000: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:34:26.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:3:0) after 1m0s
[16:35:26.300] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:3:0)
[16:35:26.300] Timer tick, asking Buildbucket for the build status
[16:35:26.688] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:26.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:4:0) after 1m0s
[16:35:26.929] Received PubSub notification, asking Buildbucket for the build status
[16:35:27.146] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:26.757] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:4:0)
[16:36:26.757] Timer tick, asking Buildbucket for the build status
[16:36:27.550] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:27.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:6:0) after 1m0s
[16:37:27.642] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:6:0)
[16:37:27.642] Timer tick, asking Buildbucket for the build status
[16:37:27.964] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:27.964] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:7:0) after 1m0s
[16:38:28.029] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:7:0)
[16:38:28.029] Timer tick, asking Buildbucket for the build status
[16:38:28.461] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:28.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:8:0) after 1m0s
[16:39:28.538] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:8:0)
[16:39:28.538] Timer tick, asking Buildbucket for the build status
[16:39:28.660] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:28.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:9:0) after 1m0s
[16:40:28.684] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:9:0)
[16:40:28.684] Timer tick, asking Buildbucket for the build status
[16:40:29.471] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:29.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:10:0) after 1m0s
[16:41:29.494] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:10:0)
[16:41:29.494] Timer tick, asking Buildbucket for the build status
[16:41:29.631] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:29.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:11:0) after 1m0s
[16:42:29.670] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:11:0)
[16:42:29.670] Timer tick, asking Buildbucket for the build status
[16:42:30.010] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:30.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:12:0) after 1m0s
[16:43:30.444] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:12:0)
[16:43:30.444] Timer tick, asking Buildbucket for the build status
[16:43:30.564] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:30.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:13:0) after 1m0s
[16:44:30.657] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:13:0)
[16:44:30.657] Timer tick, asking Buildbucket for the build status
[16:44:31.311] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:31.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:14:0) after 1m0s
[16:45:31.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:14:0)
[16:45:31.586] Timer tick, asking Buildbucket for the build status
[16:45:32.386] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:32.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:15:0) after 1m0s
[16:46:32.503] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:15:0)
[16:46:32.503] Timer tick, asking Buildbucket for the build status
[16:46:33.651] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:33.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:16:0) after 1m0s
[16:47:34.010] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:16:0)
[16:47:34.010] Timer tick, asking Buildbucket for the build status
[16:47:35.557] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:35.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:17:0) after 1m0s
[16:48:35.613] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:17:0)
[16:48:35.613] Timer tick, asking Buildbucket for the build status
[16:48:35.916] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:35.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:18:0) after 1m0s
[16:49:36.105] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:18:0)
[16:49:36.105] Timer tick, asking Buildbucket for the build status
[16:49:36.209] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:36.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:19:0) after 1m0s
[16:50:36.373] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:19:0)
[16:50:36.373] Timer tick, asking Buildbucket for the build status
[16:50:36.628] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:36.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:20:0) after 1m0s
[16:51:36.654] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:20:0)
[16:51:36.654] Timer tick, asking Buildbucket for the build status
[16:51:36.824] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:36.824] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:21:0) after 1m0s
[16:52:36.823] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:21:0)
[16:52:36.823] Timer tick, asking Buildbucket for the build status
[16:52:37.136] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:37.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:22:0) after 1m0s
[16:53:37.156] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:22:0)
[16:53:37.156] Timer tick, asking Buildbucket for the build status
[16:53:37.318] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:37.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:23:0) after 1m0s
[16:54:37.342] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:23:0)
[16:54:37.342] Timer tick, asking Buildbucket for the build status
[16:54:37.516] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:37.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:24:0) after 1m0s
[16:55:37.541] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:24:0)
[16:55:37.541] Timer tick, asking Buildbucket for the build status
[16:55:38.489] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:38.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:25:0) after 1m0s
[16:56:38.509] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:25:0)
[16:56:38.509] Timer tick, asking Buildbucket for the build status
[16:56:38.600] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:38.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:26:0) after 1m0s
[16:57:38.740] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:26:0)
[16:57:38.740] Timer tick, asking Buildbucket for the build status
[16:57:38.960] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:38.960] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:27:0) after 1m0s
[16:58:39.014] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:27:0)
[16:58:39.014] Timer tick, asking Buildbucket for the build status
[16:58:39.243] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:39.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:28:0) after 1m0s
[16:59:39.441] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:28:0)
[16:59:39.441] Timer tick, asking Buildbucket for the build status
[16:59:39.694] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:39.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:29:0) after 1m0s
[17:00:39.728] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:29:0)
[17:00:39.728] Timer tick, asking Buildbucket for the build status
[17:00:40.902] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:40.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:30:0) after 1m0s
[17:01:41.229] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:30:0)
[17:01:41.229] Timer tick, asking Buildbucket for the build status
[17:01:42.102] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:42.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:31:0) after 1m0s
[17:02:42.403] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:31:0)
[17:02:42.403] Timer tick, asking Buildbucket for the build status
[17:02:42.903] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:42.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:32:0) after 1m0s
[17:03:43.146] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:32:0)
[17:03:43.146] Timer tick, asking Buildbucket for the build status
[17:03:43.452] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:43.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:33:0) after 1m0s
[17:04:43.725] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:33:0)
[17:04:43.725] Timer tick, asking Buildbucket for the build status
[17:04:44.448] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:44.448] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:34:0) after 1m0s
[17:05:44.779] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:34:0)
[17:05:44.779] Timer tick, asking Buildbucket for the build status
[17:05:45.192] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:45.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:35:0) after 1m0s
[17:06:45.561] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:35:0)
[17:06:45.561] Timer tick, asking Buildbucket for the build status
[17:06:46.167] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:46.167] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:36:0) after 1m0s
[17:07:46.334] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:36:0)
[17:07:46.334] Timer tick, asking Buildbucket for the build status
[17:07:46.479] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:46.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:37:0) after 1m0s
[17:08:46.796] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:37:0)
[17:08:46.796] Timer tick, asking Buildbucket for the build status
[17:08:47.958] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:47.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:38:0) after 1m0s
[17:09:48.440] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:38:0)
[17:09:48.440] Timer tick, asking Buildbucket for the build status
[17:09:48.869] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:48.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:39:0) after 1m0s
[17:10:49.145] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:39:0)
[17:10:49.145] Timer tick, asking Buildbucket for the build status
[17:10:50.350] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:50.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:40:0) after 1m0s
[17:11:50.460] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:40:0)
[17:11:50.461] Timer tick, asking Buildbucket for the build status
[17:11:50.722] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:50.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:41:0) after 1m0s
[17:12:50.751] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:41:0)
[17:12:50.751] Timer tick, asking Buildbucket for the build status
[17:12:50.867] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:50.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:42:0) after 1m0s
[17:13:51.154] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:42:0)
[17:13:51.154] Timer tick, asking Buildbucket for the build status
[17:13:51.806] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:51.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:43:0) after 1m0s
[17:14:51.838] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:43:0)
[17:14:51.838] Timer tick, asking Buildbucket for the build status
[17:14:52.402] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:52.402] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:44:0) after 1m0s
[17:15:52.466] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:44:0)
[17:15:52.466] Timer tick, asking Buildbucket for the build status
[17:15:52.559] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:52.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:45:0) after 1m0s
[17:16:52.599] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:45:0)
[17:16:52.599] Timer tick, asking Buildbucket for the build status
[17:16:52.927] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:52.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:46:0) after 1m0s
[17:17:52.958] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:46:0)
[17:17:52.958] Timer tick, asking Buildbucket for the build status
[17:17:53.278] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:53.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:47:0) after 1m0s
[17:18:53.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:47:0)
[17:18:53.298] Timer tick, asking Buildbucket for the build status
[17:18:53.446] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:53.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:48:0) after 1m0s
[17:19:53.565] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:48:0)
[17:19:53.565] Timer tick, asking Buildbucket for the build status
[17:19:53.691] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:53.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:49:0) after 1m0s
[17:20:53.757] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:49:0)
[17:20:53.757] Timer tick, asking Buildbucket for the build status
[17:20:53.890] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:53.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:50:0) after 1m0s
[17:21:54.011] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:50:0)
[17:21:54.011] Timer tick, asking Buildbucket for the build status
[17:21:56.526] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:56.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:51:0) after 1m0s
[17:22:56.557] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:51:0)
[17:22:56.557] Timer tick, asking Buildbucket for the build status
[17:22:57.076] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:57.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:52:0) after 1m0s
[17:23:57.126] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:52:0)
[17:23:57.126] Timer tick, asking Buildbucket for the build status
[17:23:57.720] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:57.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:53:0) after 1m0s
[17:24:57.870] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:53:0)
[17:24:57.870] Timer tick, asking Buildbucket for the build status
[17:25:02.029] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:02.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:54:0) after 1m0s
[17:26:02.098] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:54:0)
[17:26:02.098] Timer tick, asking Buildbucket for the build status
[17:26:03.127] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:03.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:55:0) after 1m0s
[17:27:03.164] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:55:0)
[17:27:03.164] Timer tick, asking Buildbucket for the build status
[17:27:03.297] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:03.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:56:0) after 1m0s
[17:28:03.598] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:56:0)
[17:28:03.598] Timer tick, asking Buildbucket for the build status
[17:28:03.904] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:03.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:57:0) after 1m0s
[17:29:04.725] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:57:0)
[17:29:04.725] Timer tick, asking Buildbucket for the build status
[17:29:04.865] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:04.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:58:0) after 1m0s
[17:30:05.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:58:0)
[17:30:05.389] Timer tick, asking Buildbucket for the build status
[17:30:06.796] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:06.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:59:0) after 1m0s
[17:31:08.200] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:59:0)
[17:31:08.200] Timer tick, asking Buildbucket for the build status
[17:31:08.375] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:08.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:60:0) after 1m0s
[17:32:08.401] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:60:0)
[17:32:08.401] Timer tick, asking Buildbucket for the build status
[17:32:08.545] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:08.545] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:61:0) after 1m0s
[17:33:08.608] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:61:0)
[17:33:08.608] Timer tick, asking Buildbucket for the build status
[17:33:08.918] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:08.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:62:0) after 1m0s
[17:34:08.942] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:62:0)
[17:34:08.942] Timer tick, asking Buildbucket for the build status
[17:34:09.070] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:09.070] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:63:0) after 1m0s
[17:35:09.099] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:63:0)
[17:35:09.099] Timer tick, asking Buildbucket for the build status
[17:35:09.661] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:09.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:64:0) after 1m0s
[17:36:09.723] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:64:0)
[17:36:09.724] Timer tick, asking Buildbucket for the build status
[17:36:10.776] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:10.776] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:65:0) after 1m0s
[17:37:10.795] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:65:0)
[17:37:10.795] Timer tick, asking Buildbucket for the build status
[17:37:11.006] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:11.006] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:66:0) after 1m0s
[17:38:11.087] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:66:0)
[17:38:11.087] Timer tick, asking Buildbucket for the build status
[17:38:11.219] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:11.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:67:0) after 1m0s
[17:39:11.346] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:67:0)
[17:39:11.346] Timer tick, asking Buildbucket for the build status
[17:39:11.599] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:11.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:68:0) after 1m0s
[17:40:12.046] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:68:0)
[17:40:12.046] Timer tick, asking Buildbucket for the build status
[17:40:12.342] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:12.342] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:69:0) after 1m0s
[17:41:12.564] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:69:0)
[17:41:12.565] Timer tick, asking Buildbucket for the build status
[17:41:12.855] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:12.855] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:70:0) after 1m0s
[17:42:13.081] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:70:0)
[17:42:13.081] Timer tick, asking Buildbucket for the build status
[17:42:13.991] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:13.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:71:0) after 1m0s
[17:43:14.032] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:71:0)
[17:43:14.032] Timer tick, asking Buildbucket for the build status
[17:43:17.143] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:17.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:72:0) after 1m0s
[17:44:27.026] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:72:0)
[17:44:27.026] Timer tick, asking Buildbucket for the build status
[17:44:27.408] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:27.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:73:0) after 1m0s
[17:45:27.520] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:73:0)
[17:45:27.520] Timer tick, asking Buildbucket for the build status
[17:45:27.798] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:27.798] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:74:0) after 1m0s
[17:46:27.830] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:74:0)
[17:46:27.830] Timer tick, asking Buildbucket for the build status
[17:46:28.092] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:28.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:75:0) after 1m0s
[17:47:28.393] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:75:0)
[17:47:28.393] Timer tick, asking Buildbucket for the build status
[17:47:28.567] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:28.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:76:0) after 1m0s
[17:48:28.846] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:76:0)
[17:48:28.846] Timer tick, asking Buildbucket for the build status
[17:48:29.360] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:29.360] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:77:0) after 1m0s
[17:49:29.600] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:77:0)
[17:49:29.601] Timer tick, asking Buildbucket for the build status
[17:49:29.740] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:29.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:78:0) after 1m0s
[17:50:29.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:78:0)
[17:50:29.818] Timer tick, asking Buildbucket for the build status
[17:50:31.649] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:31.649] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:79:0) after 1m0s
[17:51:32.128] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:79:0)
[17:51:32.128] Timer tick, asking Buildbucket for the build status
[17:51:32.467] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:32.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:80:0) after 1m0s
[17:52:32.500] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:80:0)
[17:52:32.500] Timer tick, asking Buildbucket for the build status
[17:52:32.807] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:32.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:81:0) after 1m0s
[17:53:32.931] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:81:0)
[17:53:32.931] Timer tick, asking Buildbucket for the build status
[17:53:33.089] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:33.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:82:0) after 1m0s
[17:54:33.227] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:82:0)
[17:54:33.227] Timer tick, asking Buildbucket for the build status
[17:54:34.062] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:34.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:83:0) after 1m0s
[17:55:34.169] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:83:0)
[17:55:34.169] Timer tick, asking Buildbucket for the build status
[17:55:34.274] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:34.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:84:0) after 1m0s
[17:56:34.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:84:0)
[17:56:34.298] Timer tick, asking Buildbucket for the build status
[17:56:34.420] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:34.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:85:0) after 1m0s
[17:57:34.547] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:85:0)
[17:57:34.547] Timer tick, asking Buildbucket for the build status
[17:57:35.451] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:35.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:86:0) after 1m0s
[17:58:35.518] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:86:0)
[17:58:35.518] Timer tick, asking Buildbucket for the build status
[17:58:35.878] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:35.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:87:0) after 1m0s
[17:59:35.978] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:87:0)
[17:59:35.979] Timer tick, asking Buildbucket for the build status
[17:59:36.503] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:36.503] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:88:0) after 1m0s
[18:00:36.541] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:88:0)
[18:00:36.541] Timer tick, asking Buildbucket for the build status
[18:00:37.226] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:37.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:89:0) after 1m0s
[18:01:37.252] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:89:0)
[18:01:37.252] Timer tick, asking Buildbucket for the build status
[18:01:38.782] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:38.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:90:0) after 1m0s
[18:02:38.912] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:90:0)
[18:02:38.912] Timer tick, asking Buildbucket for the build status
[18:02:39.036] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:39.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:91:0) after 1m0s
[18:03:39.065] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:91:0)
[18:03:39.065] Timer tick, asking Buildbucket for the build status
[18:03:40.417] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:40.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:92:0) after 1m0s
[18:04:40.458] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:92:0)
[18:04:40.458] Timer tick, asking Buildbucket for the build status
[18:04:44.750] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:44.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:93:0) after 1m0s
[18:05:44.785] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:93:0)
[18:05:44.785] Timer tick, asking Buildbucket for the build status
[18:05:46.033] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:46.033] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:94:0) after 1m0s
[18:06:46.057] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:94:0)
[18:06:46.057] Timer tick, asking Buildbucket for the build status
[18:06:46.639] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:46.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:95:0) after 1m0s
[18:07:46.702] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:95:0)
[18:07:46.702] Timer tick, asking Buildbucket for the build status
[18:07:46.840] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:46.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:96:0) after 1m0s
[18:08:46.922] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:96:0)
[18:08:46.922] Timer tick, asking Buildbucket for the build status
[18:08:47.616] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:47.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:97:0) after 1m0s
[18:09:47.729] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:97:0)
[18:09:47.729] Timer tick, asking Buildbucket for the build status
[18:09:48.733] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:48.733] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:98:0) after 1m0s
[18:10:48.830] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:98:0)
[18:10:48.830] Timer tick, asking Buildbucket for the build status
[18:10:49.570] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:49.570] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:99:0) after 1m0s
[18:11:49.641] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:99:0)
[18:11:49.641] Timer tick, asking Buildbucket for the build status
[18:11:49.738] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:49.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:100:0) after 1m0s
[18:12:49.819] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:100:0)
[18:12:49.819] Timer tick, asking Buildbucket for the build status
[18:12:50.002] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:50.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:101:0) after 1m0s
[18:13:50.066] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:101:0)
[18:13:50.066] Timer tick, asking Buildbucket for the build status
[18:13:52.958] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:52.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:102:0) after 1m0s
[18:14:53.035] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:102:0)
[18:14:53.035] Timer tick, asking Buildbucket for the build status
[18:14:53.731] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:53.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:103:0) after 1m0s
[18:15:53.935] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:103:0)
[18:15:53.935] Timer tick, asking Buildbucket for the build status
[18:15:55.432] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:55.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:104:0) after 1m0s
[18:16:55.537] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:104:0)
[18:16:55.537] Timer tick, asking Buildbucket for the build status
[18:16:55.880] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:55.880] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:105:0) after 1m0s
[18:17:56.015] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:105:0)
[18:17:56.015] Timer tick, asking Buildbucket for the build status
[18:17:56.487] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:56.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:106:0) after 1m0s
[18:18:56.512] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:106:0)
[18:18:56.512] Timer tick, asking Buildbucket for the build status
[18:18:56.617] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:56.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:107:0) after 1m0s
[18:19:56.648] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:107:0)
[18:19:56.648] Timer tick, asking Buildbucket for the build status
[18:19:57.126] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:57.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:108:0) after 1m0s
[18:20:57.441] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:108:0)
[18:20:57.441] Timer tick, asking Buildbucket for the build status
[18:20:58.322] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:58.322] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:109:0) after 1m0s
[18:21:58.648] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:109:0)
[18:21:58.648] Timer tick, asking Buildbucket for the build status
[18:22:01.615] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:01.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:110:0) after 1m0s
[18:23:01.638] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:110:0)
[18:23:01.638] Timer tick, asking Buildbucket for the build status
[18:23:01.808] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:01.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:111:0) after 1m0s
[18:24:01.892] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:111:0)
[18:24:01.892] Timer tick, asking Buildbucket for the build status
[18:24:05.056] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:05.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:112:0) after 1m0s
[18:25:05.129] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:112:0)
[18:25:05.129] Timer tick, asking Buildbucket for the build status
[18:25:05.240] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:05.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:113:0) after 1m0s
[18:26:05.318] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:113:0)
[18:26:05.318] Timer tick, asking Buildbucket for the build status
[18:26:05.428] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:05.428] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:114:0) after 1m0s
[18:27:05.473] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:114:0)
[18:27:05.473] Timer tick, asking Buildbucket for the build status
[18:27:05.685] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:05.685] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:115:0) after 1m0s
[18:28:05.726] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:115:0)
[18:28:05.726] Timer tick, asking Buildbucket for the build status
[18:28:07.921] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:07.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:116:0) after 1m0s
[18:29:07.985] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:116:0)
[18:29:07.985] Timer tick, asking Buildbucket for the build status
[18:29:08.550] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:08.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:117:0) after 1m0s
[18:30:08.581] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:117:0)
[18:30:08.581] Timer tick, asking Buildbucket for the build status
[18:30:09.830] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:09.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:118:0) after 1m0s
[18:31:09.856] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:118:0)
[18:31:09.856] Timer tick, asking Buildbucket for the build status
[18:31:10.037] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:10.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:119:0) after 1m0s
[18:32:10.058] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:119:0)
[18:32:10.058] Timer tick, asking Buildbucket for the build status
[18:32:12.267] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:12.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:120:0) after 1m0s
[18:33:12.302] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:120:0)
[18:33:12.302] Timer tick, asking Buildbucket for the build status
[18:33:12.794] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:12.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:121:0) after 1m0s
[18:34:12.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:121:0)
[18:34:12.818] Timer tick, asking Buildbucket for the build status
[18:34:13.227] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:13.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:122:0) after 1m0s
[18:35:13.250] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:122:0)
[18:35:13.250] Timer tick, asking Buildbucket for the build status
[18:35:13.587] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:13.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:123:0) after 1m0s
[18:36:13.608] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:123:0)
[18:36:13.608] Timer tick, asking Buildbucket for the build status
[18:36:13.794] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:13.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:124:0) after 1m0s
[18:37:13.820] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:124:0)
[18:37:13.820] Timer tick, asking Buildbucket for the build status
[18:37:13.952] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:13.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:125:0) after 1m0s
[18:38:14.007] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:125:0)
[18:38:14.007] Timer tick, asking Buildbucket for the build status
[18:38:14.274] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:14.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:126:0) after 1m0s
[18:39:14.311] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:126:0)
[18:39:14.311] Timer tick, asking Buildbucket for the build status
[18:39:15.308] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:15.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:127:0) after 1m0s
[18:40:15.341] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:127:0)
[18:40:15.341] Timer tick, asking Buildbucket for the build status
[18:40:16.133] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:16.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:128:0) after 1m0s
[18:41:16.253] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:128:0)
[18:41:16.253] Timer tick, asking Buildbucket for the build status
[18:41:18.833] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:18.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:129:0) after 1m0s
[18:42:18.857] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:129:0)
[18:42:18.857] Timer tick, asking Buildbucket for the build status
[18:42:19.241] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:19.241] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:130:0) after 1m0s
[18:43:19.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:130:0)
[18:43:19.275] Timer tick, asking Buildbucket for the build status
[18:43:19.399] Build 8911202991123724000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:19.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076633061076855152:131:0) after 1m0s
[18:43:24.950] Received PubSub notification, asking Buildbucket for the build status
[18:43:25.680] Build 8911202991123724000: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:43:25.680] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1560019403967829",
"created_by": "project:chromium",
"created_ts": "1560011601290040",
"id": "8911202991123724000",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4bad77148cc4a36373e40cf985444bc649c0eeff\"}}",
"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\": \"build284-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOSDevice\", \"buildnumber\": 12512, \"got_angle_revision\": \"2d0a9acb05511a8fdaf0cd27d0da22599516a68b\", \"got_dawn_revision\": \"7eb6be186be60a536a9f529b514bb5c5fd79293d\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"4bad77148cc4a36373e40cf985444bc649c0eeff\", \"got_revision_cp\": \"refs/heads/master@{#667463}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"05e98a6eb753853cfbdabf257eba8cc633d5975f\", \"got_v8_revision_cp\": \"refs/heads/7.7.27@{#1}\", \"got_webrtc_revision\": \"54c9d89f69c50ae180e818528081404582a59a9c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28200}\", \"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\": \"4bad77148cc4a36373e40cf985444bc649c0eeff\", \"swarm_hashes\": {\"0\": \"033e4d855f89b4e4fda413de50a7f7c0280f04f7\", \"1\": \"12da0c30641b8b16fdf56c1c3374bd28960b7037\", \"10\": \"8aa12aa19eed51e76c20f37e97e64dad6846e66f\", \"11\": \"fd30446dc1ae43a2bf4caf9800b87c4a6792594b\", \"12\": \"c8a9bf11453f9f7110c5455b108fff3878b1b180\", \"13\": \"523a3da68937e953e846308504fb23b02a67e1fc\", \"14\": \"2c4b52bbd16e90fc5eed887bd49ab7190cda39a4\", \"15\": \"0e1e2632a7fb5a6efaa94228f6b7ec7d5da08d7c\", \"16\": \"e2a79d442a17d12ebb25e50af99c854a304d77d0\", \"2\": \"66254f2840ce2a1cf6d4a6d3aefaf2519f4104eb\", \"3\": \"decf013506c8680305b9d4773911a19c26f48cb3\", \"4\": \"ee6b039dca9084e0b94c5839d9e25ef77b0620c0\", \"5\": \"14cebc9987b03b87e085dd62fc1a105aac96be0f\", \"6\": \"7e1e02cb128b397e09da97994d33a1bccf1bcba2\", \"7\": \"47c66c90397baa0320e6e09434a41f334c97896b\", \"8\": \"1c128b7ec71f517255f04b67f931de92259eff3f\", \"9\": \"51a8f2e00a1660fc7615fed7eedaee05ced19aa3\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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\": [\"build284-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\": [\"4332-2f8e532\"], \"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": "1560011725758032",
"status": "COMPLETED",
"status_changed_ts": "1560019404334912",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12512",
"builder:ToTiOSDevice",
"buildset:commit/git/4bad77148cc4a36373e40cf985444bc649c0eeff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4bad77148cc4a36373e40cf985444bc649c0eeff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076633061076855152",
"scheduler_job_id:chromium/ToTiOSDevice",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8911202991123724000/+/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:4550c1e24b969910",
"user_agent:luci-scheduler"
],
"updated_ts": "1560019404361508",
"url": "https://ci.chromium.org/b/8911202991123724000",
"utcnow_ts": "1560019405655930"
}
}
[18:43:25.680] Invocation finished in 2h10m13.264875485s with status SUCCEEDED