[15:29:46.916] New invocation is queued and will start shortly
[15:29:48.547] Starting the invocation (attempt 1)
[15:29:48.715] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:29:48.716] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:29:48.716] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9068120936608001152",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"652f4db4a799f3957e4141d230e2caa9ae1a550b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9068120936608001152",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/652f4db4a799f3957e4141d230e2caa9ae1a550b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/652f4db4a799f3957e4141d230e2caa9ae1a550b",
"gitiles_ref:refs/heads/master"
]
}
[15:29:50.320] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1568129389110407",
"id": "8902690873642795408",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"652f4db4a799f3957e4141d230e2caa9ae1a550b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1568129389695082",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9836",
"builder:ToTiOS",
"buildset:commit/git/652f4db4a799f3957e4141d230e2caa9ae1a550b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/652f4db4a799f3957e4141d230e2caa9ae1a550b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068120936608001152",
"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/8902690873642795408/+/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": "1568129389695200",
"url": "https://ci.chromium.org/b/8902690873642795408",
"utcnow_ts": "1568129390291633"
}
}
[15:29:50.320] Task URL: https://ci.chromium.org/b/8902690873642795408
[15:29:50.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:2:0) after 1m0s
[15:30:50.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:2:0)
[15:30:50.389] Timer tick, asking Buildbucket for the build status
[15:30:50.804] Build 8902690873642795408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:30:50.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:3:0) after 1m0s
[15:31:50.845] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:3:0)
[15:31:50.845] Timer tick, asking Buildbucket for the build status
[15:31:51.010] Build 8902690873642795408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:31:51.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:4:0) after 1m0s
[15:32:51.047] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:4:0)
[15:32:51.047] Timer tick, asking Buildbucket for the build status
[15:32:51.378] Build 8902690873642795408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:32:51.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:5:0) after 1m0s
[15:33:08.201] Received PubSub notification, asking Buildbucket for the build status
[15:33:08.407] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:51.411] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:5:0)
[15:33:51.411] Timer tick, asking Buildbucket for the build status
[15:33:51.648] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:51.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:7:0) after 1m0s
[15:34:51.716] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:7:0)
[15:34:51.716] Timer tick, asking Buildbucket for the build status
[15:34:52.450] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:52.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:8:0) after 1m0s
[15:35:52.485] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:8:0)
[15:35:52.485] Timer tick, asking Buildbucket for the build status
[15:35:52.739] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:52.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:9:0) after 1m0s
[15:36:52.790] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:9:0)
[15:36:52.790] Timer tick, asking Buildbucket for the build status
[15:36:53.012] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:53.012] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:10:0) after 1m0s
[15:37:53.060] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:10:0)
[15:37:53.060] Timer tick, asking Buildbucket for the build status
[15:37:53.340] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:53.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:11:0) after 1m0s
[15:38:53.370] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:11:0)
[15:38:53.370] Timer tick, asking Buildbucket for the build status
[15:38:53.988] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:53.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:12:0) after 1m0s
[15:39:54.121] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:12:0)
[15:39:54.121] Timer tick, asking Buildbucket for the build status
[15:39:54.741] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:54.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:13:0) after 1m0s
[15:40:54.803] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:13:0)
[15:40:54.803] Timer tick, asking Buildbucket for the build status
[15:40:55.190] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:55.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:14:0) after 1m0s
[15:41:55.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:14:0)
[15:41:55.218] Timer tick, asking Buildbucket for the build status
[15:41:58.831] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:58.831] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:15:0) after 1m0s
[15:42:58.893] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:15:0)
[15:42:58.893] Timer tick, asking Buildbucket for the build status
[15:42:59.160] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:59.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:16:0) after 1m0s
[15:43:59.221] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:16:0)
[15:43:59.221] Timer tick, asking Buildbucket for the build status
[15:43:59.426] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:59.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:17:0) after 1m0s
[15:44:59.493] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:17:0)
[15:44:59.493] Timer tick, asking Buildbucket for the build status
[15:44:59.713] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:59.713] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:18:0) after 1m0s
[15:45:59.737] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:18:0)
[15:45:59.737] Timer tick, asking Buildbucket for the build status
[15:46:02.782] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:02.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:19:0) after 1m0s
[15:47:02.784] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:19:0)
[15:47:02.784] Timer tick, asking Buildbucket for the build status
[15:47:02.955] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:02.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:20:0) after 1m0s
[15:48:02.977] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:20:0)
[15:48:02.977] Timer tick, asking Buildbucket for the build status
[15:48:03.658] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:03.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:21:0) after 1m0s
[15:49:03.776] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:21:0)
[15:49:03.776] Timer tick, asking Buildbucket for the build status
[15:49:04.056] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:04.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:22:0) after 1m0s
[15:50:04.108] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:22:0)
[15:50:04.108] Timer tick, asking Buildbucket for the build status
[15:50:04.575] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:04.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:23:0) after 1m0s
[15:51:04.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:23:0)
[15:51:04.650] Timer tick, asking Buildbucket for the build status
[15:51:05.594] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:05.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:24:0) after 1m0s
[15:52:05.697] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:24:0)
[15:52:05.697] Timer tick, asking Buildbucket for the build status
[15:52:06.164] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:06.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:25:0) after 1m0s
[15:53:06.353] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:25:0)
[15:53:06.353] Timer tick, asking Buildbucket for the build status
[15:53:06.691] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:06.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:26:0) after 1m0s
[15:54:06.810] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:26:0)
[15:54:06.810] Timer tick, asking Buildbucket for the build status
[15:54:07.229] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:07.229] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:27:0) after 1m0s
[15:55:07.318] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:27:0)
[15:55:07.318] Timer tick, asking Buildbucket for the build status
[15:55:12.625] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:12.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:28:0) after 1m0s
[15:56:12.782] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:28:0)
[15:56:12.782] Timer tick, asking Buildbucket for the build status
[15:56:13.535] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:13.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:29:0) after 1m0s
[15:57:13.582] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:29:0)
[15:57:13.582] Timer tick, asking Buildbucket for the build status
[15:57:17.099] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:17.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:30:0) after 1m0s
[15:58:17.119] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:30:0)
[15:58:17.119] Timer tick, asking Buildbucket for the build status
[15:58:21.493] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:21.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:31:0) after 1m0s
[15:59:21.627] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:31:0)
[15:59:21.627] Timer tick, asking Buildbucket for the build status
[15:59:23.265] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:23.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:32:0) after 1m0s
[16:00:23.330] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:32:0)
[16:00:23.330] Timer tick, asking Buildbucket for the build status
[16:00:24.325] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:24.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:33:0) after 1m0s
[16:01:24.697] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:33:0)
[16:01:24.697] Timer tick, asking Buildbucket for the build status
[16:01:25.185] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:25.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:34:0) after 1m0s
[16:02:25.252] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:34:0)
[16:02:25.252] Timer tick, asking Buildbucket for the build status
[16:02:25.436] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:25.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:35:0) after 1m0s
[16:03:25.565] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:35:0)
[16:03:25.565] Timer tick, asking Buildbucket for the build status
[16:03:25.803] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:25.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:36:0) after 1m0s
[16:04:25.829] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:36:0)
[16:04:25.829] Timer tick, asking Buildbucket for the build status
[16:04:25.980] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:25.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:37:0) after 1m0s
[16:05:25.999] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:37:0)
[16:05:25.999] Timer tick, asking Buildbucket for the build status
[16:05:27.175] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:27.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:38:0) after 1m0s
[16:06:27.203] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:38:0)
[16:06:27.203] Timer tick, asking Buildbucket for the build status
[16:06:29.509] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:29.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:39:0) after 1m0s
[16:07:29.633] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:39:0)
[16:07:29.633] Timer tick, asking Buildbucket for the build status
[16:07:30.206] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:30.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:40:0) after 1m0s
[16:08:30.260] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:40:0)
[16:08:30.260] Timer tick, asking Buildbucket for the build status
[16:08:31.715] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:31.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:41:0) after 1m0s
[16:09:31.862] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:41:0)
[16:09:31.862] Timer tick, asking Buildbucket for the build status
[16:09:32.112] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:32.112] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:42:0) after 1m0s
[16:10:32.220] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:42:0)
[16:10:32.220] Timer tick, asking Buildbucket for the build status
[16:10:32.448] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:32.448] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:43:0) after 1m0s
[16:11:32.501] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:43:0)
[16:11:32.501] Timer tick, asking Buildbucket for the build status
[16:11:33.178] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:33.178] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:44:0) after 1m0s
[16:12:33.231] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:44:0)
[16:12:33.231] Timer tick, asking Buildbucket for the build status
[16:12:33.448] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:33.448] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:45:0) after 1m0s
[16:13:33.531] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:45:0)
[16:13:33.531] Timer tick, asking Buildbucket for the build status
[16:13:33.926] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:33.926] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:46:0) after 1m0s
[16:14:33.962] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:46:0)
[16:14:33.962] Timer tick, asking Buildbucket for the build status
[16:14:34.287] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:34.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:47:0) after 1m0s
[16:15:34.357] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:47:0)
[16:15:34.357] Timer tick, asking Buildbucket for the build status
[16:15:34.644] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:34.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:48:0) after 1m0s
[16:16:34.715] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:48:0)
[16:16:34.715] Timer tick, asking Buildbucket for the build status
[16:16:35.201] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:35.201] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:49:0) after 1m0s
[16:17:35.221] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:49:0)
[16:17:35.221] Timer tick, asking Buildbucket for the build status
[16:17:35.582] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:35.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:50:0) after 1m0s
[16:18:35.610] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:50:0)
[16:18:35.610] Timer tick, asking Buildbucket for the build status
[16:18:35.846] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:35.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:51:0) after 1m0s
[16:19:36.013] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:51:0)
[16:19:36.013] Timer tick, asking Buildbucket for the build status
[16:19:36.542] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:36.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:52:0) after 1m0s
[16:20:36.685] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:52:0)
[16:20:36.685] Timer tick, asking Buildbucket for the build status
[16:20:36.935] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:36.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:53:0) after 1m0s
[16:21:37.012] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:53:0)
[16:21:37.012] Timer tick, asking Buildbucket for the build status
[16:21:41.001] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:41.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:54:0) after 1m0s
[16:22:41.635] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:54:0)
[16:22:41.635] Timer tick, asking Buildbucket for the build status
[16:22:41.984] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:41.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:55:0) after 1m0s
[16:23:42.069] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:55:0)
[16:23:42.069] Timer tick, asking Buildbucket for the build status
[16:23:42.717] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:42.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:56:0) after 1m0s
[16:24:42.825] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:56:0)
[16:24:42.825] Timer tick, asking Buildbucket for the build status
[16:24:43.791] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:43.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:57:0) after 1m0s
[16:25:43.977] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:57:0)
[16:25:43.977] Timer tick, asking Buildbucket for the build status
[16:25:46.717] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:46.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:58:0) after 1m0s
[16:26:46.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:58:0)
[16:26:46.818] Timer tick, asking Buildbucket for the build status
[16:26:49.948] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:49.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:59:0) after 1m0s
[16:27:50.015] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:59:0)
[16:27:50.016] Timer tick, asking Buildbucket for the build status
[16:27:50.227] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:50.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:60:0) after 1m0s
[16:28:50.291] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:60:0)
[16:28:50.291] Timer tick, asking Buildbucket for the build status
[16:28:50.514] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:50.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:61:0) after 1m0s
[16:29:50.696] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:61:0)
[16:29:50.697] Timer tick, asking Buildbucket for the build status
[16:29:50.967] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:50.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:62:0) after 1m0s
[16:30:51.166] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:62:0)
[16:30:51.166] Timer tick, asking Buildbucket for the build status
[16:30:51.465] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:51.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:63:0) after 1m0s
[16:31:51.520] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:63:0)
[16:31:51.520] Timer tick, asking Buildbucket for the build status
[16:31:52.415] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:52.415] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:64:0) after 1m0s
[16:32:52.588] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:64:0)
[16:32:52.588] Timer tick, asking Buildbucket for the build status
[16:32:54.901] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:54.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:65:0) after 1m0s
[16:33:55.043] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:65:0)
[16:33:55.043] Timer tick, asking Buildbucket for the build status
[16:33:55.834] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:55.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:66:0) after 1m0s
[16:34:55.876] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:66:0)
[16:34:55.876] Timer tick, asking Buildbucket for the build status
[16:34:56.941] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:56.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:67:0) after 1m0s
[16:35:57.004] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:67:0)
[16:35:57.004] Timer tick, asking Buildbucket for the build status
[16:35:57.283] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:57.283] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:68:0) after 1m0s
[16:36:57.402] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:68:0)
[16:36:57.402] Timer tick, asking Buildbucket for the build status
[16:36:59.993] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:59.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:69:0) after 1m0s
[16:37:59.991] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:69:0)
[16:37:59.991] Timer tick, asking Buildbucket for the build status
[16:38:01.635] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:01.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:70:0) after 1m0s
[16:39:01.656] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:70:0)
[16:39:01.656] Timer tick, asking Buildbucket for the build status
[16:39:05.729] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:05.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:71:0) after 1m0s
[16:40:05.753] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:71:0)
[16:40:05.753] Timer tick, asking Buildbucket for the build status
[16:40:06.395] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:06.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:72:0) after 1m0s
[16:41:06.452] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:72:0)
[16:41:06.453] Timer tick, asking Buildbucket for the build status
[16:41:06.882] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:06.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:73:0) after 1m0s
[16:42:06.925] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:73:0)
[16:42:06.925] Timer tick, asking Buildbucket for the build status
[16:42:10.266] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:10.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:74:0) after 1m0s
[16:43:10.451] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:74:0)
[16:43:10.451] Timer tick, asking Buildbucket for the build status
[16:43:11.041] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:11.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:75:0) after 1m0s
[16:44:11.076] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:75:0)
[16:44:11.076] Timer tick, asking Buildbucket for the build status
[16:44:11.350] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:11.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:76:0) after 1m0s
[16:45:11.378] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:76:0)
[16:45:11.378] Timer tick, asking Buildbucket for the build status
[16:45:11.774] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:11.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:77:0) after 1m0s
[16:46:11.824] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:77:0)
[16:46:11.824] Timer tick, asking Buildbucket for the build status
[16:46:12.097] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:12.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:78:0) after 1m0s
[16:47:12.409] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:78:0)
[16:47:12.409] Timer tick, asking Buildbucket for the build status
[16:47:15.927] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:15.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:79:0) after 1m0s
[16:48:16.325] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:79:0)
[16:48:16.325] Timer tick, asking Buildbucket for the build status
[16:48:16.757] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:16.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:80:0) after 1m0s
[16:49:16.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:80:0)
[16:49:16.818] Timer tick, asking Buildbucket for the build status
[16:49:17.689] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:17.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:81:0) after 1m0s
[16:50:17.825] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:81:0)
[16:50:17.825] Timer tick, asking Buildbucket for the build status
[16:50:18.198] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:18.198] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:82:0) after 1m0s
[16:51:18.444] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:82:0)
[16:51:18.444] Timer tick, asking Buildbucket for the build status
[16:51:19.756] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:19.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:83:0) after 1m0s
[16:52:19.871] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:83:0)
[16:52:19.871] Timer tick, asking Buildbucket for the build status
[16:52:20.042] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:20.042] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:84:0) after 1m0s
[16:53:20.150] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:84:0)
[16:53:20.150] Timer tick, asking Buildbucket for the build status
[16:53:20.303] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:20.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:85:0) after 1m0s
[16:54:20.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:85:0)
[16:54:20.356] Timer tick, asking Buildbucket for the build status
[16:54:21.505] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:21.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:86:0) after 1m0s
[16:55:21.613] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:86:0)
[16:55:21.613] Timer tick, asking Buildbucket for the build status
[16:55:21.868] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:21.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:87:0) after 1m0s
[16:56:21.907] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:87:0)
[16:56:21.907] Timer tick, asking Buildbucket for the build status
[16:56:22.640] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:22.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:88:0) after 1m0s
[16:57:22.792] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:88:0)
[16:57:22.792] Timer tick, asking Buildbucket for the build status
[16:57:23.023] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:23.023] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:89:0) after 1m0s
[16:58:23.151] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:89:0)
[16:58:23.151] Timer tick, asking Buildbucket for the build status
[16:58:29.325] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:29.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:90:0) after 1m0s
[16:59:29.469] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:90:0)
[16:59:29.469] Timer tick, asking Buildbucket for the build status
[16:59:30.154] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:30.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:91:0) after 1m0s
[17:00:30.174] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:91:0)
[17:00:30.174] Timer tick, asking Buildbucket for the build status
[17:00:30.529] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:30.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:92:0) after 1m0s
[17:01:30.784] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:92:0)
[17:01:30.784] Timer tick, asking Buildbucket for the build status
[17:01:31.017] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:31.017] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:93:0) after 1m0s
[17:02:31.045] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:93:0)
[17:02:31.045] Timer tick, asking Buildbucket for the build status
[17:02:31.320] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:31.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:94:0) after 1m0s
[17:03:31.419] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:94:0)
[17:03:31.419] Timer tick, asking Buildbucket for the build status
[17:03:38.156] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:38.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:95:0) after 1m0s
[17:04:38.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:95:0)
[17:04:38.389] Timer tick, asking Buildbucket for the build status
[17:04:38.874] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:38.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:96:0) after 1m0s
[17:05:38.936] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:96:0)
[17:05:38.936] Timer tick, asking Buildbucket for the build status
[17:05:39.370] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:39.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:97:0) after 1m0s
[17:06:39.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:97:0)
[17:06:39.586] Timer tick, asking Buildbucket for the build status
[17:06:40.533] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:40.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:98:0) after 1m0s
[17:07:40.556] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:98:0)
[17:07:40.556] Timer tick, asking Buildbucket for the build status
[17:07:40.902] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:40.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:99:0) after 1m0s
[17:08:40.990] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:99:0)
[17:08:40.990] Timer tick, asking Buildbucket for the build status
[17:08:41.578] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:41.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:100:0) after 1m0s
[17:09:41.781] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:100:0)
[17:09:41.781] Timer tick, asking Buildbucket for the build status
[17:09:42.887] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:42.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:101:0) after 1m0s
[17:10:42.996] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:101:0)
[17:10:42.996] Timer tick, asking Buildbucket for the build status
[17:10:43.575] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:43.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:102:0) after 1m0s
[17:11:43.611] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:102:0)
[17:11:43.611] Timer tick, asking Buildbucket for the build status
[17:11:45.019] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:45.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:103:0) after 1m0s
[17:12:45.116] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:103:0)
[17:12:45.116] Timer tick, asking Buildbucket for the build status
[17:12:45.500] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:45.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:104:0) after 1m0s
[17:13:45.580] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:104:0)
[17:13:45.580] Timer tick, asking Buildbucket for the build status
[17:13:46.994] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:46.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:105:0) after 1m0s
[17:14:47.031] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:105:0)
[17:14:47.031] Timer tick, asking Buildbucket for the build status
[17:14:49.793] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:49.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:106:0) after 1m0s
[17:15:50.030] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:106:0)
[17:15:50.030] Timer tick, asking Buildbucket for the build status
[17:15:50.625] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:50.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:107:0) after 1m0s
[17:16:50.711] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:107:0)
[17:16:50.711] Timer tick, asking Buildbucket for the build status
[17:16:51.004] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:51.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:108:0) after 1m0s
[17:17:51.232] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:108:0)
[17:17:51.232] Timer tick, asking Buildbucket for the build status
[17:17:51.501] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:51.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:109:0) after 1m0s
[17:18:51.566] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:109:0)
[17:18:51.566] Timer tick, asking Buildbucket for the build status
[17:18:52.647] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:52.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:110:0) after 1m0s
[17:19:52.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:110:0)
[17:19:52.731] Timer tick, asking Buildbucket for the build status
[17:19:53.151] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:53.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:111:0) after 1m0s
[17:20:53.198] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:111:0)
[17:20:53.198] Timer tick, asking Buildbucket for the build status
[17:20:53.461] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:53.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:112:0) after 1m0s
[17:21:53.507] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:112:0)
[17:21:53.507] Timer tick, asking Buildbucket for the build status
[17:21:54.066] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:54.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:113:0) after 1m0s
[17:22:54.195] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:113:0)
[17:22:54.195] Timer tick, asking Buildbucket for the build status
[17:22:56.385] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:56.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:114:0) after 1m0s
[17:23:56.607] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:114:0)
[17:23:56.607] Timer tick, asking Buildbucket for the build status
[17:23:57.454] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:57.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:115:0) after 1m0s
[17:24:57.705] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:115:0)
[17:24:57.705] Timer tick, asking Buildbucket for the build status
[17:25:03.296] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:03.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:116:0) after 1m0s
[17:26:03.334] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:116:0)
[17:26:03.334] Timer tick, asking Buildbucket for the build status
[17:26:04.507] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:04.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:117:0) after 1m0s
[17:27:04.611] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:117:0)
[17:27:04.611] Timer tick, asking Buildbucket for the build status
[17:27:04.812] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:04.812] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:118:0) after 1m0s
[17:28:04.864] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:118:0)
[17:28:04.864] Timer tick, asking Buildbucket for the build status
[17:28:05.386] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:05.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:119:0) after 1m0s
[17:29:05.503] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:119:0)
[17:29:05.503] Timer tick, asking Buildbucket for the build status
[17:29:05.804] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:05.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:120:0) after 1m0s
[17:30:05.887] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:120:0)
[17:30:05.887] Timer tick, asking Buildbucket for the build status
[17:30:06.206] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:06.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:121:0) after 1m0s
[17:31:06.273] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:121:0)
[17:31:06.273] Timer tick, asking Buildbucket for the build status
[17:31:07.784] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:07.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:122:0) after 1m0s
[17:32:07.919] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:122:0)
[17:32:07.919] Timer tick, asking Buildbucket for the build status
[17:32:08.104] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:08.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:123:0) after 1m0s
[17:33:08.209] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:123:0)
[17:33:08.209] Timer tick, asking Buildbucket for the build status
[17:33:08.554] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:08.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:124:0) after 1m0s
[17:34:08.682] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:124:0)
[17:34:08.682] Timer tick, asking Buildbucket for the build status
[17:34:09.039] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:09.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:125:0) after 1m0s
[17:35:09.092] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:125:0)
[17:35:09.092] Timer tick, asking Buildbucket for the build status
[17:35:09.332] Build 8902690873642795408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:09.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068120936608001152:126:0) after 1m0s
[17:35:34.803] Received PubSub notification, asking Buildbucket for the build status
[17:35:35.349] Build 8902690873642795408: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[17:35:35.349] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1568136934264436",
"created_by": "project:chromium",
"created_ts": "1568129389110407",
"failure_reason": "BUILD_FAILURE",
"id": "8902690873642795408",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"652f4db4a799f3957e4141d230e2caa9ae1a550b\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_web_inttests (iPhone 6s iOS 12.2).\"}, \"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\": \"build285-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 9836, \"got_angle_revision\": \"79ad0411911b2fc84834c3705f55707be9e4b498\", \"got_dawn_revision\": \"a900ccebcf428c99184ca44a3fad6030b2e43fc7\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"652f4db4a799f3957e4141d230e2caa9ae1a550b\", \"got_revision_cp\": \"refs/heads/master@{#695173}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"e6d242c02cbb0bf0290a766678c754e941c747d8\", \"got_v8_revision_cp\": \"refs/heads/7.9.8@{#1}\", \"got_webrtc_revision\": \"45b01c7962da7bbd08a35ba59ad3e360457c6563\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29134}\", \"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\": \"652f4db4a799f3957e4141d230e2caa9ae1a550b\", \"swarm_hashes\": {\"0\": \"f35273a83931aef69cd8d0d0c1799ad782dde7a3\", \"1\": \"bd0d5be8fc3ff27f4da5eb6da5a481ed4f7a528b\", \"10\": \"b5d0e6e7737981306761787220fdf1064d5ea681\", \"11\": \"eb7562073ca1bc2677fa24400215c3921b252840\", \"12\": \"733921e154005733db08e3d7c939c0f5ad00dbbc\", \"13\": \"9e11aa16e14af88e0177a6b8c10e7fe4bb56f4a6\", \"14\": \"fb9ab6effb8783084f6633375a382684da06d415\", \"15\": \"5eba4b217a255cc0f474904088f46884034621f2\", \"16\": \"f35f947078544fd1e93bbf9e0448e8e132e71d71\", \"2\": \"ac5ef11c92caaaaf88523ce7a9aebbc23e945d5f\", \"3\": \"61ed00577be7dc96861a5e842f7c0aea968d552c\", \"4\": \"d7bcd5ffdedaf8119c8ceafc802cda07628bf0bd\", \"5\": \"23668589c4d6c945236d8ce68281e7cb483e8b84\", \"6\": \"77eada8834837df5a8e077b7567dc0317c6a528f\", \"7\": \"ed71cebca8f3b9241d98a0d40e39be352eec5a61\", \"8\": \"34305f089d149637993e04b38931f99062b49e7e\", \"9\": \"7bc3541fa79eaa00e48326c6802dc788d1a5ed41\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11m382q\", \"xcode_ios_11m392q\", \"xcode_ios_11m392r\"], \"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\": [\"build285-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4423-0229127\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_web_inttests (iPhone 6s iOS 12.2).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1568129586532199",
"status": "COMPLETED",
"status_changed_ts": "1568129587118746",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9836",
"builder:ToTiOS",
"buildset:commit/git/652f4db4a799f3957e4141d230e2caa9ae1a550b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/652f4db4a799f3957e4141d230e2caa9ae1a550b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068120936608001152",
"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/8902690873642795408/+/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:47349d1dcd4b5810",
"user_agent:luci-scheduler"
],
"updated_ts": "1568136934362367",
"url": "https://ci.chromium.org/b/8902690873642795408",
"utcnow_ts": "1568136935336164"
}
}
[17:35:35.349] Invocation finished in 2h5m48.450148383s with status FAILED